2009-11-21 22:07:15.642652 [DEBUG] sofia_glue.c:2811 Activate Buggy RFC2833 Mode! 2009-11-21 22:07:15.642652 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMU:0:8000:20] 2009-11-21 22:07:15.650807 [DEBUG] sofia_glue.c:3071 Audio Codec Compare [PCMA:8:8000:0]/[PCMA:8:8000:20] 2009-11-21 22:07:15.672560 [DEBUG] sofia_glue.c:2029 Set Codec sofia/external/nobody@213.166.5.133 PCMA/8000 20 ms 160 samples 2009-11-21 22:07:15.676936 [DEBUG] sofia_glue.c:3031 Set 2833 dtmf payload to 101 2009-11-21 22:07:15.676936 [DEBUG] sofia.c:3455 (sofia/external/nobody@213.166.5.133) State Change CS_NEW -> CS_INIT 2009-11-21 22:07:15.676936 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody@213.166.5.133 [BREAK] 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody@213.166.5.133) Running State Change CS_INIT 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:481 (sofia/external/nobody@213.166.5.133) State INIT 2009-11-21 22:07:15.676936 [DEBUG] mod_sofia.c:83 sofia/external/nobody@213.166.5.133 SOFIA INIT 2009-11-21 22:07:15.676936 [DEBUG] mod_sofia.c:111 (sofia/external/nobody@213.166.5.133) State Change CS_INIT -> CS_ROUTING 2009-11-21 22:07:15.676936 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody@213.166.5.133 [BREAK] 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:481 (sofia/external/nobody@213.166.5.133) State INIT going to sleep 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody@213.166.5.133) Running State Change CS_ROUTING 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:484 (sofia/external/nobody@213.166.5.133) State ROUTING 2009-11-21 22:07:15.676936 [DEBUG] mod_sofia.c:130 sofia/external/nobody@213.166.5.133 SOFIA ROUTING 2009-11-21 22:07:15.676936 [DEBUG] switch_core_state_machine.c:78 sofia/external/nobody@213.166.5.133 Standard ROUTING 2009-11-21 22:07:15.696693 [INFO] mod_dialplan_xml.c:315 Processing anonymous->abeka in context public Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->unloop] continue=false Dialplan: sofia/external/nobody@213.166.5.133 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->outside_call] continue=true Dialplan: sofia/external/nobody@213.166.5.133 Absolute Condition [outside_call] Dialplan: sofia/external/nobody@213.166.5.133 Action set(outside_call=true) Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->call_debug] continue=true Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->public_extensions] continue=false Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [public_extensions] destination_number(abeka) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->public_did] continue=false Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [public_did] destination_number(abeka) =~ /^(5551212)$/ break=on-false Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->sip@sip.voipuser.org] continue=false Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [sip@sip.voipuser.org] destination_number(abeka) =~ /08715042951/ break=on-false Dialplan: sofia/external/nobody@213.166.5.133 parsing [public->Inbound-abeka@sip.voipuser.org]] continue=false Dialplan: sofia/external/nobody@213.166.5.133 Regex (FAIL) [Inbound-abeka@sip.voipuser.org]] destination_number(abeka) =~ /[08444846450]/ break=on-false 2009-11-21 22:07:15.704513 [DEBUG] switch_core_state_machine.c:114 (sofia/external/nobody@213.166.5.133) State Change CS_ROUTING -> CS_EXECUTE 2009-11-21 22:07:15.704513 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody@213.166.5.133 [BREAK] 2009-11-21 22:07:15.704513 [DEBUG] switch_core_state_machine.c:484 (sofia/external/nobody@213.166.5.133) State ROUTING going to sleep 2009-11-21 22:07:15.704513 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody@213.166.5.133) Running State Change CS_EXECUTE 2009-11-21 22:07:15.704513 [DEBUG] switch_core_state_machine.c:491 (sofia/external/nobody@213.166.5.133) State EXECUTE 2009-11-21 22:07:15.706658 [DEBUG] mod_sofia.c:173 sofia/external/nobody@213.166.5.133 SOFIA EXECUTE 2009-11-21 22:07:15.706658 [DEBUG] switch_core_state_machine.c:151 sofia/external/nobody@213.166.5.133 Standard EXECUTE EXECUTE sofia/external/nobody@213.166.5.133 set(outside_call=true) 2009-11-21 22:07:15.728613 [DEBUG] mod_dptools.c:748 sofia/external/nobody@213.166.5.133 SET [outside_call]=[true] 2009-11-21 22:07:15.728613 [NOTICE] switch_core_state_machine.c:179 Hangup sofia/external/nobody@213.166.5.133 [CS_EXECUTE] [NORMAL_CLEARING] 2009-11-21 22:07:15.728613 [DEBUG] switch_channel.c:1683 Send signal sofia/external/nobody@213.166.5.133 [KILL] 2009-11-21 22:07:15.728613 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody@213.166.5.133 [BREAK] 2009-11-21 22:07:15.728613 [DEBUG] switch_core_state_machine.c:491 (sofia/external/nobody@213.166.5.133) State EXECUTE going to sleep 2009-11-21 22:07:15.728613 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody@213.166.5.133) Running State Change CS_HANGUP 2009-11-21 22:07:15.735830 [DEBUG] switch_core_state_machine.c:434 (sofia/external/nobody@213.166.5.133) State HANGUP 2009-11-21 22:07:15.735830 [DEBUG] mod_sofia.c:338 Channel sofia/external/nobody@213.166.5.133 hanging up, cause: NORMAL_CLEARING 2009-11-21 22:07:15.737680 [DEBUG] mod_sofia.c:417 Responding to INVITE with: 480 2009-11-21 22:07:15.741149 [DEBUG] switch_core_state_machine.c:46 sofia/external/nobody@213.166.5.133 Standard HANGUP, cause: NORMAL_CLEARING 2009-11-21 22:07:15.741149 [DEBUG] switch_core_state_machine.c:434 (sofia/external/nobody@213.166.5.133) State HANGUP going to sleep 2009-11-21 22:07:15.742930 [DEBUG] switch_core_state_machine.c:476 (sofia/external/nobody@213.166.5.133) State Change CS_HANGUP -> CS_REPORTING 2009-11-21 22:07:15.742930 [DEBUG] switch_core_session.c:932 Send signal sofia/external/nobody@213.166.5.133 [BREAK] 2009-11-21 22:07:15.744587 [DEBUG] switch_core_state_machine.c:398 (sofia/external/nobody@213.166.5.133) Running State Change CS_REPORTING 2009-11-21 22:07:15.744587 [DEBUG] switch_core_state_machine.c:612 (sofia/external/nobody@213.166.5.133) State REPORTING 2009-11-21 22:07:15.800497 [DEBUG] switch_core_state_machine.c:53 sofia/external/nobody@213.166.5.133 Standard REPORTING, cause: NORMAL_CLEARING 2009-11-21 22:07:15.800497 [DEBUG] switch_core_state_machine.c:612 (sofia/external/nobody@213.166.5.133) State REPORTING going to sleep 2009-11-21 22:07:15.800497 [DEBUG] switch_core_state_machine.c:411 (sofia/external/nobody@213.166.5.133) State Change CS_REPORTING -> CS_DESTROY 2009-11-21 22:07:15.800497 [DEBUG] switch_core_session.c:1068 Session 2 (sofia/external/nobody@213.166.5.133) Locked, Waiting on external entities 2009-11-21 22:07:15.800497 [NOTICE] switch_core_session.c:1086 Session 2 (sofia/external/nobody@213.166.5.133) Ended 2009-11-21 22:07:15.800497 [NOTICE] switch_core_session.c:1088 Close Channel sofia/external/nobody@213.166.5.133 [CS_DESTROY] 2009-11-21 22:07:15.802636 [DEBUG] switch_core_state_machine.c:564 (sofia/external/nobody@213.166.5.133) State DESTROY 2009-11-21 22:07:15.802636 [DEBUG] mod_sofia.c:255 sofia/external/nobody@213.166.5.133 SOFIA DESTROY 2009-11-21 22:07:15.802636 [DEBUG] switch_core_state_machine.c:60 sofia/external/nobody@213.166.5.133 Standard DESTROY 2009-11-21 22:07:15.802636 [DEBUG] switch_core_state_machine.c:564 (sofia/external/nobody@213.166.5.133) State DESTROY going to sleep