gistfile1.txt

2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 0 = [ppcc_campaign_slug=emg-edu]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 1 = [ppcc_test_call=yeppers]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 2 = [ppcc_pitch_pk=2]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 3 = [cc_base_score=0]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 4 = [ppcc_dial_string=sofia/ppcc_queretaro/ajamaica-laptop%emg]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 5 = [ignore_early_media=true]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 6 = [ppcc_queue_name=emg-edu@emg]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 7 = [ppcc_call_leg_type=prospect]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 8 = [ppcc_prospect_id=1960258]
2011-06-06 11:19:29.980690 [DEBUG] switch_ivr_originate.c:1973 variable string 9 = [ppcc_start_node=gk_hello]
2011-06-06 11:19:29.981754 [NOTICE] switch_channel.c:812 New Channel sofia/ppcc_queretaro/ajamaica-laptop [366484d3-6786-4225-a310-68b3d2da4e1c]
2011-06-06 11:19:29.984120 [DEBUG] mod_sofia.c:4286 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_NEW -> CS_INIT
2011-06-06 11:19:29.984120 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:19:29.984120 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_INIT
2011-06-06 11:19:29.984120 [DEBUG] switch_core_state_machine.c:356 (sofia/ppcc_queretaro/ajamaica-laptop) State INIT
2011-06-06 11:19:29.984120 [DEBUG] mod_sofia.c:84 sofia/ppcc_queretaro/ajamaica-laptop SOFIA INIT
2011-06-06 11:19:29.985885 [WARNING] sofia_glue.c:213 Codec iLBC payload 101 added to sdp wanting ptime 30 but it's already 20 (SPEEX:99:20), disabling ptime.
2011-06-06 11:19:29.985885 [DEBUG] mod_sofia.c:124 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_INIT -> CS_ROUTING
2011-06-06 11:19:29.985885 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:19:29.985885 [DEBUG] sofia.c:4749 Channel sofia/ppcc_queretaro/ajamaica-laptop entering state [calling][0]
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:356 (sofia/ppcc_queretaro/ajamaica-laptop) State INIT going to sleep
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_ROUTING
2011-06-06 11:19:29.985885 [DEBUG] switch_channel.c:1668 (sofia/ppcc_queretaro/ajamaica-laptop) Callstate Change DOWN -> RINGING
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:359 (sofia/ppcc_queretaro/ajamaica-laptop) State ROUTING
2011-06-06 11:19:29.985885 [DEBUG] mod_sofia.c:147 sofia/ppcc_queretaro/ajamaica-laptop SOFIA ROUTING
2011-06-06 11:19:29.985885 [DEBUG] switch_ivr_originate.c:66 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2011-06-06 11:19:29.985885 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:359 (sofia/ppcc_queretaro/ajamaica-laptop) State ROUTING going to sleep
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_CONSUME_MEDIA
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:378 (sofia/ppcc_queretaro/ajamaica-laptop) State CONSUME_MEDIA
2011-06-06 11:19:29.985885 [DEBUG] switch_core_state_machine.c:378 (sofia/ppcc_queretaro/ajamaica-laptop) State CONSUME_MEDIA going to sleep

freeswitch@internal> 
2011-06-06 11:19:30.248491 [INFO] sofia.c:739 sofia/ppcc_queretaro/ajamaica-laptop Update Callee ID to "Outbound Call" <ajamaica-laptop>
freeswitch@internal> 2011-06-06 11:19:30.250883 [DEBUG] sofia.c:4749 Channel sofia/ppcc_queretaro/ajamaica-laptop entering state [proceeding][180]
2011-06-06 11:19:30.250883 [NOTICE] sofia.c:4827 Ring-Ready sofia/ppcc_queretaro/ajamaica-laptop!





======CALLING ENDS=======
======WHEN I ANSWER =====

2011-06-06 11:20:50.997804 [DEBUG] sofia.c:4749 Channel sofia/ppcc_queretaro/ajamaica-laptop entering state [completing][200]
2011-06-06 11:20:50.997804 [DEBUG] sofia.c:4760 Remote SDP:
v=0
o=- 1307377250980214 1 IN IP4 192.168.1.2
s=CounterPath X-Lite 4.0
c=IN IP4 192.168.1.2
t=0 0
a=ice-ufrag:c8a438
a=ice-pwd:364fd5650b09f154189cabcd8bd2a239
m=audio 57834 RTP/AVP 0 8
a=candidate:1 1 UDP 659136 192.168.1.2 57834 typ host
a=candidate:1 2 UDP 659134 192.168.1.2 57835 typ host

2011-06-06 11:20:50.997804 [DEBUG] sofia.c:4749 Channel sofia/ppcc_queretaro/ajamaica-laptop entering state [ready][200]
2011-06-06 11:20:50.997804 [DEBUG] sofia_glue.c:4637 Audio Codec Compare [PCMU:0:8000:20:64000]/[SPEEX:99:8000:20:24600]
2011-06-06 11:20:50.997804 [DEBUG] sofia_glue.c:4637 Audio Codec Compare [PCMU:0:8000:20:64000]/[SPEEX:99:16000:20:42200]
2011-06-06 11:20:50.997804 [DEBUG] sofia_glue.c:4637 Audio Codec Compare [PCMU:0:8000:20:64000]/[SPEEX:99:32000:20:44000]
2011-06-06 11:20:50.997804 [DEBUG] sofia_glue.c:4637 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
2011-06-06 11:20:50.997804 [DEBUG] sofia_glue.c:2760 Set Codec sofia/ppcc_queretaro/ajamaica-laptop PCMU/8000 20 ms 160 samples 64000 bits
2011-06-06 11:20:50.999262 [DEBUG] sofia_glue.c:3001 AUDIO RTP [sofia/ppcc_queretaro/ajamaica-laptop] 192.168.1.120 port 16762 -> 192.168.1.2 port 57834 codec: 0 ms: 20
2011-06-06 11:20:50.999262 [DEBUG] switch_rtp.c:1623 Starting timer [soft] 160 bytes per 20ms
2011-06-06 11:20:51.000324 [DEBUG] switch_channel.c:2813 (sofia/ppcc_queretaro/ajamaica-laptop) Callstate Change RINGING -> ACTIVE
2011-06-06 11:20:51.000324 [NOTICE] sofia.c:5333 Channel [sofia/ppcc_queretaro/ajamaica-laptop] has been answered
2011-06-06 11:20:51.001386 [DEBUG] switch_ivr_originate.c:3412 Originate Resulted in Success: [sofia/ppcc_queretaro/ajamaica-laptop]
2011-06-06 11:20:51.001386 [INFO] switch_channel.c:2457 sofia/ppcc_queretaro/ajamaica-laptop Flipping CID from "DegrMentor" <8018057995> to "Outbound Call" <ajamaica-laptop>
2011-06-06 11:20:51.001386 [DEBUG] mod_commands.c:3357 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
2011-06-06 11:20:51.001386 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:20:51.001386 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_EXECUTE
2011-06-06 11:20:51.001386 [DEBUG] switch_core_state_machine.c:366 (sofia/ppcc_queretaro/ajamaica-laptop) State EXECUTE
2011-06-06 11:20:51.001386 [DEBUG] mod_sofia.c:240 sofia/ppcc_queretaro/ajamaica-laptop SOFIA EXECUTE
2011-06-06 11:20:51.001386 [DEBUG] switch_core_state_machine.c:157 sofia/ppcc_queretaro/ajamaica-laptop Standard EXECUTE
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop park()
2011-06-06 11:20:51.001386 [DEBUG] switch_ivr.c:766 Codec Activated L16@8000hz 1 channels 20ms
2011-06-06 11:20:51.012133 [DEBUG] switch_core_media_bug.c:360 Attaching BUG to sofia/ppcc_queretaro/ajamaica-laptop
2011-06-06 11:20:51.018630 [DEBUG] switch_ivr.c:1600 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_EXECUTE -> CS_ROUTING
2011-06-06 11:20:51.018630 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:20:51.018630 [DEBUG] switch_core_session.c:709 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:20:51.018630 [NOTICE] switch_ivr.c:1606 Transfer sofia/ppcc_queretaro/ajamaica-laptop to XML[ppcc_place_into_queue@default]
2011-06-06 11:20:51.022877 [DEBUG] switch_core_state_machine.c:366 (sofia/ppcc_queretaro/ajamaica-laptop) State EXECUTE going to sleep
2011-06-06 11:20:51.022877 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_ROUTING
2011-06-06 11:20:51.022877 [DEBUG] switch_channel.c:1668 (sofia/ppcc_queretaro/ajamaica-laptop) Callstate Change ACTIVE -> RINGING
2011-06-06 11:20:51.022877 [DEBUG] switch_core_state_machine.c:359 (sofia/ppcc_queretaro/ajamaica-laptop) State ROUTING
2011-06-06 11:20:51.022877 [DEBUG] mod_sofia.c:147 sofia/ppcc_queretaro/ajamaica-laptop SOFIA ROUTING
2011-06-06 11:20:51.022877 [DEBUG] switch_core_state_machine.c:77 sofia/ppcc_queretaro/ajamaica-laptop Standard ROUTING
2011-06-06 11:20:51.022877 [INFO] mod_dialplan_xml.c:331 Processing Outbound Call <ajamaica-laptop>->ppcc_place_into_queue in context default
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_call] continue=true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_call] destination_number(ppcc_place_into_queue) =~ /^111[0-9]$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_call] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_call] destination_number(ppcc_place_into_queue) =~ /^1110$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_call] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_call] destination_number(ppcc_place_into_queue) =~ /^111([1-2])$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_callback] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_callback] destination_number(ppcc_place_into_queue) =~ /^1113$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_callback_alt] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_callback_alt] destination_number(ppcc_place_into_queue) =~ /^1114$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_callback_unmatched_prospect] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_callback_unmatched_prospect] destination_number(ppcc_place_into_queue) =~ /^1115$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_warm_transfer] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_warm_transfer] destination_number(ppcc_place_into_queue) =~ /^1116$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_inbound] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_inbound] destination_number(ppcc_place_into_queue) =~ /^1117$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_unmatched_campaign] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_unmatched_campaign] destination_number(ppcc_place_into_queue) =~ /^1118$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_test_transfer] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ppcc_test_transfer] destination_number(ppcc_place_into_queue) =~ /^test-transfer$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->unloop] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->holiday_example] continue=true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Date/Time Match (FAIL) [holiday_example] break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->global-intercept] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [global-intercept] destination_number(ppcc_place_into_queue) =~ /^886$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->group-intercept] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [group-intercept] destination_number(ppcc_place_into_queue) =~ /^\*8$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->intercept-ext] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [intercept-ext] destination_number(ppcc_place_into_queue) =~ /^\*\*(\d+)$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->redial] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [redial] destination_number(ppcc_place_into_queue) =~ /^(redial|870)$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->global] continue=true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [global] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Absolute Condition [global]
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action hash(insert/${domain_name}-last_dial/global/${uuid}) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->eavesdrop] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [eavesdrop] destination_number(ppcc_place_into_queue) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->eavesdrop] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [eavesdrop] destination_number(ppcc_place_into_queue) =~ /^779$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->call_return] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [call_return] destination_number(ppcc_place_into_queue) =~ /^\*69$|^869$|^lcr$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->del-group] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [del-group] destination_number(ppcc_place_into_queue) =~ /^80(\d{2})$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->add-group] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [add-group] destination_number(ppcc_place_into_queue) =~ /^81(\d{2})$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->call-group-simo] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [call-group-simo] destination_number(ppcc_place_into_queue) =~ /^82(\d{2})$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->call-group-order] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [call-group-order] destination_number(ppcc_place_into_queue) =~ /^83(\d{2})$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->extension-intercom] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [extension-intercom] destination_number(ppcc_place_into_queue) =~ /^8(10[01][0-9])$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->Local_Extension] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [Local_Extension] destination_number(ppcc_place_into_queue) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->group_dial_support] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [group_dial_support] destination_number(ppcc_place_into_queue) =~ /^2001$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->operator] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [operator] destination_number(ppcc_place_into_queue) =~ /^(operator|0)$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->vmain] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [vmain] destination_number(ppcc_place_into_queue) =~ /^vmain$|^4000$|^\*98$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->park] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [park] destination_number(ppcc_place_into_queue) =~ /^5900$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->unpark] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [unpark] destination_number(ppcc_place_into_queue) =~ /^5901$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->valet_park] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [valet_park] destination_number(ppcc_place_into_queue) =~ /^(6000)$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->valet_park] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [valet_park] destination_number(ppcc_place_into_queue) =~ /^(60\d[1-9])$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->wait] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [wait] destination_number(ppcc_place_into_queue) =~ /^wait$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->fax_receive] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [fax_receive] destination_number(ppcc_place_into_queue) =~ /^9178$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->fax_transmit] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [fax_transmit] destination_number(ppcc_place_into_queue) =~ /^9179$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ringback_180] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ringback_180] destination_number(ppcc_place_into_queue) =~ /^9180$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ringback_183_uk_ring] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ringback_183_uk_ring] destination_number(ppcc_place_into_queue) =~ /^9181$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ringback_183_music_ring] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ringback_183_music_ring] destination_number(ppcc_place_into_queue) =~ /^9182$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ringback_post_answer_uk_ring] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(ppcc_place_into_queue) =~ /^9183$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ringback_post_answer_music] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [ringback_post_answer_music] destination_number(ppcc_place_into_queue) =~ /^9184$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->show_info] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [show_info] destination_number(ppcc_place_into_queue) =~ /^9192$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->delay_echo] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [delay_echo] destination_number(ppcc_place_into_queue) =~ /^9195$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->echo] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [echo] destination_number(ppcc_place_into_queue) =~ /^9196$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->milliwatt] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [milliwatt] destination_number(ppcc_place_into_queue) =~ /^9197$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->tone_stream] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [tone_stream] destination_number(ppcc_place_into_queue) =~ /^9198$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->hold_music] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [hold_music] destination_number(ppcc_place_into_queue) =~ /^9664$/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->local.example.com] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [local.example.com] ${toll_allow}() =~ /local/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->domestic.example.com] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [domestic.example.com] ${toll_allow}() =~ /domestic/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->international.example.com] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (FAIL) [international.example.com] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop parsing [default->ppcc_place_into_queue] continue=false
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Regex (PASS) [ppcc_place_into_queue] destination_number(ppcc_place_into_queue) =~ /^ppcc_place_into_queue$/ break=on-true
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action answer() 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action set(ppcc_in_queue=true) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action callcenter(${ppcc_queue_name}) 
Dialplan: sofia/ppcc_queretaro/ajamaica-laptop Action voicemail(default ${ppcc_domain} ${ppcc_voicemail_station}) 
2011-06-06 11:20:51.097013 [DEBUG] switch_core_state_machine.c:119 (sofia/ppcc_queretaro/ajamaica-laptop) State Change CS_ROUTING -> CS_EXECUTE
2011-06-06 11:20:51.097013 [DEBUG] switch_core_session.c:1116 Send signal sofia/ppcc_queretaro/ajamaica-laptop [BREAK]
2011-06-06 11:20:51.097013 [DEBUG] switch_core_state_machine.c:359 (sofia/ppcc_queretaro/ajamaica-laptop) State ROUTING going to sleep
2011-06-06 11:20:51.097013 [DEBUG] switch_core_state_machine.c:320 (sofia/ppcc_queretaro/ajamaica-laptop) Running State Change CS_EXECUTE
2011-06-06 11:20:51.097013 [DEBUG] switch_channel.c:1670 (sofia/ppcc_queretaro/ajamaica-laptop) Callstate Change RINGING -> ACTIVE
2011-06-06 11:20:51.097013 [DEBUG] switch_core_state_machine.c:366 (sofia/ppcc_queretaro/ajamaica-laptop) State EXECUTE
2011-06-06 11:20:51.097013 [DEBUG] mod_sofia.c:240 sofia/ppcc_queretaro/ajamaica-laptop SOFIA EXECUTE
2011-06-06 11:20:51.097013 [DEBUG] switch_core_state_machine.c:157 sofia/ppcc_queretaro/ajamaica-laptop Standard EXECUTE
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop hash(insert/-spymap/ajamaica-laptop/e757bad2-f522-4be7-b7f0-13e706e83c6a)
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop hash(insert/-last_dial/ajamaica-laptop/ppcc_place_into_queue)
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop hash(insert/-last_dial/global/e757bad2-f522-4be7-b7f0-13e706e83c6a)
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop set(RFC2822_DATE=Mon, 06 Jun 2011 11:20:51 -0500)
2011-06-06 11:20:51.099308 [DEBUG] mod_dptools.c:1059 sofia/ppcc_queretaro/ajamaica-laptop SET [RFC2822_DATE]=[Mon, 06 Jun 2011 11:20:51 -0500]
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop answer()
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop set(ppcc_in_queue=true)
2011-06-06 11:20:51.102173 [DEBUG] mod_dptools.c:1059 sofia/ppcc_queretaro/ajamaica-laptop SET [ppcc_in_queue]=[true]
EXECUTE sofia/ppcc_queretaro/ajamaica-laptop callcenter(emg-edu@emg)
2011-06-06 11:20:51.104556 [DEBUG] switch_core_file.c:176 File /media_root/recordings/resources/degree-mentor-queue.wav sample rate 44100 doesn't match requested rate 8000
2011-06-06 11:20:51.104556 [WARNING] switch_core_file.c:189 File has 2 channels, muxing to mono will occur.
2011-06-06 11:20:51.104556 [DEBUG] switch_ivr_play_say.c:1291 Codec Activated L16@8000hz 2 channels 20ms
2011-06-06 11:20:51.262407 [DEBUG] switch_rtp.c:3082 Correct ip/port confirmed.
2011-06-06 11:20:56.170873 [ERR] mod_xml_cdr.c:365 Got error [0] posting to web server [http://10.10.85.3:80/xml_cdr/c0a8017886c1/cdr/]
2011-06-06 11:20:56.170873 [ERR] mod_xml_cdr.c:372 Retry will be with url [http://10.10.85.3:80/xml_cdr/c0a8017886c1/cdr/]