recv 1113 bytes from udp/[64.134.240.14]:34840 at 21:45:12.084783: ------------------------------------------------------------------------ INVITE sip:9888@freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPjnNF9KX3qB68PhdxxqINUIjbioXmjn2UG Max-Forwards: 70 From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: Contact: Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31861 INVITE Route: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, timer, norefersub Session-Expires: 1800 Min-SE: 90 User-Agent: CSipSimple r1108 / picasso-13 Content-Type: application/sdp Content-Length: 388 v=0 o=- 3541095914 3541095914 IN IP4 192.168.5.37 s=pjmedia c=IN IP4 192.168.5.37 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 9 107 106 105 0 8 101 a=rtcp:4001 IN IP4 192.168.5.37 a=rtpmap:9 G722/8000 a=rtpmap:107 speex/32000 a=rtpmap:106 speex/16000 a=rtpmap:105 speex/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ------------------------------------------------------------------------ send 355 bytes to udp/[64.134.240.14]:34840 at 21:45:12.085144: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPjnNF9KX3qB68PhdxxqINUIjbioXmjn2UG From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31861 INVITE User-Agent: Configured by 2600hz! Content-Length: 0 ------------------------------------------------------------------------ send 845 bytes to udp/[64.134.240.14]:34840 at 21:45:12.085774: ------------------------------------------------------------------------ SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPjnNF9KX3qB68PhdxxqINUIjbioXmjn2UG From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: ;tag=5c5vej2t9t0Ug Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31861 INVITE User-Agent: Configured by 2600hz! Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authenticate: Digest realm="freeswitch.voipqso.com", nonce="a3b0ebe6-7143-11e1-919c-698b09f7d618", algorithm=MD5, qop="auth" Content-Length: 0 ------------------------------------------------------------------------ recv 427 bytes from udp/[64.134.240.14]:34840 at 21:45:12.193593: ------------------------------------------------------------------------ ACK sip:9888@freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPjnNF9KX3qB68PhdxxqINUIjbioXmjn2UG Max-Forwards: 70 From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: ;tag=5c5vej2t9t0Ug Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31861 ACK Route: Content-Length: 0 ------------------------------------------------------------------------ recv 1401 bytes from udp/[64.134.240.14]:34840 at 21:45:12.208814: ------------------------------------------------------------------------ INVITE sip:9888@freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPj2.WJ3I2P1CXs7eKf0J0WIbByUAHVfIOA Max-Forwards: 70 From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: Contact: Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31862 INVITE Route: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, timer, norefersub Session-Expires: 1800 Min-SE: 90 User-Agent: CSipSimple r1108 / picasso-13 Proxy-Authorization: Digest username="2917", realm="freeswitch.voipqso.com", nonce="a3b0ebe6-7143-11e1-919c-698b09f7d618", uri="sip:9888@freeswitch.voipqso.com", response="4c8a8cae6c3cd93e6ec6a6223160f8aa", algorithm=MD5, cnonce="MjQEDzCSHdSWGqwmRSCKUM9iCvqTeGft", qop=auth, nc=00000001 Content-Type: application/sdp Content-Length: 388 v=0 o=- 3541095914 3541095914 IN IP4 192.168.5.37 s=pjmedia c=IN IP4 192.168.5.37 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 9 107 106 105 0 8 101 a=rtcp:4001 IN IP4 192.168.5.37 a=rtpmap:9 G722/8000 a=rtpmap:107 speex/32000 a=rtpmap:106 speex/16000 a=rtpmap:105 speex/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ------------------------------------------------------------------------ send 355 bytes to udp/[64.134.240.14]:34840 at 21:45:12.209179: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPj2.WJ3I2P1CXs7eKf0J0WIbByUAHVfIOA From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31862 INVITE User-Agent: Configured by 2600hz! Content-Length: 0 ------------------------------------------------------------------------ 2012-03-19 01:45:12.197757 [NOTICE] switch_channel.c:926 New Channel sofia/sipinterface_1/2917@freeswitch.voipqso.com [a3c3fba0-7143-11e1-919d-698b09f7d618] 2012-03-19 01:45:12.197757 [DEBUG] sofia.c:5532 Channel sofia/sipinterface_1/2917@freeswitch.voipqso.com entering state [received][100] 2012-03-19 01:45:12.197757 [DEBUG] sofia.c:5543 Remote SDP: v=0 o=- 3541095914 3541095914 IN IP4 192.168.5.37 s=pjmedia c=IN IP4 192.168.5.37 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 9 107 106 105 0 8 101 a=rtpmap:9 G722/8000 a=rtpmap:107 speex/32000 a=rtpmap:106 speex/16000 a=rtpmap:105 speex/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=rtcp:4001 IN IP4 192.168.5.37 2012-03-19 01:45:12.197757 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [G722:9:8000:20:64000]/[G7221:115:32000:20:48000] 2012-03-19 01:45:12.197757 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [G722:9:8000:20:64000]/[G7221:107:16000:20:32000] 2012-03-19 01:45:12.197757 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [G722:9:8000:20:64000]/[G722:9:8000:20:64000] 2012-03-19 01:45:12.197757 [DEBUG] sofia_glue.c:2996 Set Codec sofia/sipinterface_1/2917@freeswitch.voipqso.com G722/8000 20 ms 160 samples 64000 bits 2012-03-19 01:45:12.197757 [DEBUG] switch_core_codec.c:111 sofia/sipinterface_1/2917@freeswitch.voipqso.com Original read codec set to G722:9 2012-03-19 01:45:12.197757 [DEBUG] sofia_glue.c:5000 Set 2833 dtmf send/recv payload to 101 2012-03-19 01:45:12.197757 [DEBUG] sofia.c:5757 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State Change CS_NEW -> CS_INIT 2012-03-19 01:45:12.197757 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_INIT 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:401 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State INIT 2012-03-19 01:45:12.197757 [DEBUG] mod_sofia.c:85 sofia/sipinterface_1/2917@freeswitch.voipqso.com SOFIA INIT 2012-03-19 01:45:12.197757 [DEBUG] mod_sofia.c:125 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State Change CS_INIT -> CS_ROUTING 2012-03-19 01:45:12.197757 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:401 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State INIT going to sleep 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_ROUTING 2012-03-19 01:45:12.197757 [CONSOLE] sofia_presence.c:1357 Event Thread Started 2012-03-19 01:45:12.197757 [DEBUG] switch_channel.c:1886 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Callstate Change DOWN -> RINGING 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State ROUTING 2012-03-19 01:45:12.197757 [DEBUG] mod_sofia.c:148 sofia/sipinterface_1/2917@freeswitch.voipqso.com SOFIA ROUTING 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:104 sofia/sipinterface_1/2917@freeswitch.voipqso.com Standard ROUTING 2012-03-19 01:45:12.197757 [INFO] mod_dialplan_xml.c:485 Processing 2917 <2917>->9888 in context context_1 Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com parsing [context_1->conditioning_callerid] continue=true Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Regex (PASS) [conditioning_callerid] ${internal_caller_id_number}(2917) =~ /^.+$/ break=on-false Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(effective_caller_id_name=${internal_caller_id_name}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(effective_caller_id_number=${internal_caller_id_number}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com parsing [context_1->postroute_global] continue=true Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Absolute Condition [postroute_global] Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com parsing [context_1->main_number_8] continue=true Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Regex (FAIL) [main_number_8] destination_number(9888) =~ /^\*9001$/ break=on-false Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com parsing [context_1->main_number_9] continue=true Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Regex (PASS) [main_number_9] destination_number(9888) =~ /^9888$/ break=on-false Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(call_timeout=30) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(ringback=${us-ring}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action set(transfer_ringback=${us-ring}) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action export(sip_callee_id_name=9888) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action export(sip_callee_id_number=9888) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action bridge({group_confirm_file=ivr/ivr-accept_reject_voicemail.wav,group_confirm_key=1,leg_timeout=}sofia/sipinterface_3/888@voipqso.com:5060) Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Action hangup() Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com parsing [context_1->main_number_10] continue=true Dialplan: sofia/sipinterface_1/2917@freeswitch.voipqso.com Regex (FAIL) [main_number_10] destination_number(9888) =~ /^2917$/ break=on-false 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:154 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State Change CS_ROUTING -> CS_EXECUTE 2012-03-19 01:45:12.197757 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State ROUTING going to sleep 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_EXECUTE 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:417 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State EXECUTE 2012-03-19 01:45:12.197757 [DEBUG] mod_sofia.c:241 sofia/sipinterface_1/2917@freeswitch.voipqso.com SOFIA EXECUTE 2012-03-19 01:45:12.197757 [DEBUG] switch_core_state_machine.c:192 sofia/sipinterface_1/2917@freeswitch.voipqso.com Standard EXECUTE EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(effective_caller_id_name=n3glv csip) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [effective_caller_id_name]=[n3glv csip] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(effective_caller_id_number=2917) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [effective_caller_id_number]=[2917] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com hash(insert/freeswitch.voipqso.com-spymap/2917/a3c3fba0-7143-11e1-919d-698b09f7d618) EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com hash(insert/freeswitch.voipqso.com-last_dial/2917/9888) EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com hash(insert/freeswitch.voipqso.com-last_dial/global/a3c3fba0-7143-11e1-919d-698b09f7d618) EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(RFC2822_DATE=Mon, 19 Mar 2012 01:45:12 +0400) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [RFC2822_DATE]=[Mon, 19 Mar 2012 01:45:12 +0400] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(call_timeout=30) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [call_timeout]=[30] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(ringback=%(2000,4000,440,480)) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [ringback]=[%(2000,4000,440,480)] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com set(transfer_ringback=%(2000,4000,440,480)) 2012-03-19 01:45:12.217750 [DEBUG] mod_dptools.c:1281 sofia/sipinterface_1/2917@freeswitch.voipqso.com SET [transfer_ringback]=[%(2000,4000,440,480)] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com export(sip_callee_id_name=9888) 2012-03-19 01:45:12.217750 [DEBUG] switch_channel.c:1093 EXPORT (export_vars) [sip_callee_id_name]=[9888] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com export(sip_callee_id_number=9888) 2012-03-19 01:45:12.217750 [DEBUG] switch_channel.c:1093 EXPORT (export_vars) [sip_callee_id_number]=[9888] EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com bridge({group_confirm_file=ivr/ivr-accept_reject_voicemail.wav,group_confirm_key=1,leg_timeout=}sofia/sipinterface_3/888@voipqso.com:5060) 2012-03-19 01:45:12.217750 [DEBUG] switch_channel.c:1047 sofia/sipinterface_1/2917@freeswitch.voipqso.com EXPORTING[export_vars] [sip_callee_id_name]=[9888] to event 2012-03-19 01:45:12.217750 [DEBUG] switch_channel.c:1047 sofia/sipinterface_1/2917@freeswitch.voipqso.com EXPORTING[export_vars] [sip_callee_id_number]=[9888] to event 2012-03-19 01:45:12.217750 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables 2012-03-19 01:45:12.217750 [DEBUG] switch_event.c:1522 Parsing variable [group_confirm_file]=[ivr/ivr-accept_reject_voicemail.wav] 2012-03-19 01:45:12.217750 [DEBUG] switch_event.c:1522 Parsing variable [group_confirm_key]=[1] 2012-03-19 01:45:12.217750 [NOTICE] switch_channel.c:926 New Channel sofia/sipinterface_3/888@voipqso.com:5060 [a3c5e87a-7143-11e1-91a2-698b09f7d618] 2012-03-19 01:45:12.217750 [DEBUG] mod_sofia.c:4691 (sofia/sipinterface_3/888@voipqso.com:5060) State Change CS_NEW -> CS_INIT 2012-03-19 01:45:12.217750 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_INIT 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:401 (sofia/sipinterface_3/888@voipqso.com:5060) State INIT 2012-03-19 01:45:12.217750 [DEBUG] mod_sofia.c:85 sofia/sipinterface_3/888@voipqso.com:5060 SOFIA INIT 2012-03-19 01:45:12.217750 [DEBUG] switch_core_session.c:877 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.217750 [DEBUG] mod_sofia.c:125 (sofia/sipinterface_3/888@voipqso.com:5060) State Change CS_INIT -> CS_ROUTING 2012-03-19 01:45:12.217750 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:401 (sofia/sipinterface_3/888@voipqso.com:5060) State INIT going to sleep 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_ROUTING 2012-03-19 01:45:12.217750 [DEBUG] switch_channel.c:1886 (sofia/sipinterface_3/888@voipqso.com:5060) Callstate Change DOWN -> RINGING 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_3/888@voipqso.com:5060) State ROUTING 2012-03-19 01:45:12.217750 [DEBUG] mod_sofia.c:148 sofia/sipinterface_3/888@voipqso.com:5060 SOFIA ROUTING send 1199 bytes to udp/[8.22.205.37]:5060 at 21:45:12.225471: ------------------------------------------------------------------------ INVITE sip:888@voipqso.com:5060 SIP/2.0 Via: SIP/2.0/UDP 184.82.20.140:5080;rport;branch=z9hG4bK3jvct0mD0KZKN Max-Forwards: 69 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717492 INVITE Contact: User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 315 X-FS-Support: update_display,send_info Remote-Party-ID: "n3glv csip" ;party=calling;screen=yes;privacy=off v=0 o=FreeSWITCH 1332078906 1332078907 IN IP4 184.82.20.140 s=FreeSWITCH c=IN IP4 184.82.20.140 t=0 0 m=audio 28206 RTP/AVP 9 98 99 0 8 3 101 13 a=rtpmap:98 G7221/32000 a=fmtp:98 bitrate=48000 a=rtpmap:99 G7221/16000 a=fmtp:99 bitrate=32000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ 2012-03-19 01:45:12.217750 [DEBUG] switch_ivr_originate.c:66 (sofia/sipinterface_3/888@voipqso.com:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2012-03-19 01:45:12.217750 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_3/888@voipqso.com:5060) State ROUTING going to sleep 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_CONSUME_MEDIA 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:429 (sofia/sipinterface_3/888@voipqso.com:5060) State CONSUME_MEDIA 2012-03-19 01:45:12.217750 [DEBUG] switch_core_state_machine.c:429 (sofia/sipinterface_3/888@voipqso.com:5060) State CONSUME_MEDIA going to sleep 2012-03-19 01:45:12.217750 [DEBUG] sofia.c:5532 Channel sofia/sipinterface_3/888@voipqso.com:5060 entering state [calling][0] recv 482 bytes from udp/[8.22.205.37]:5060 at 21:45:12.277057: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 184.82.20.140:5080;branch=z9hG4bK3jvct0mD0KZKN;received=184.82.20.140;rport=5080 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717492 INVITE Server: FPBX-2.8.1(1.8.3.3) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Content-Length: 0 ------------------------------------------------------------------------ recv 807 bytes from udp/[8.22.205.37]:5060 at 21:45:12.392003: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 184.82.20.140:5080;branch=z9hG4bK3jvct0mD0KZKN;received=184.82.20.140;rport=5080 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: ;tag=as71d7a24b Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717492 INVITE Server: FPBX-2.8.1(1.8.3.3) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Content-Type: application/sdp Content-Length: 281 v=0 o=root 1445719820 1445719820 IN IP4 8.22.205.37 s=Asterisk PBX 1.8.3.3 c=IN IP4 8.22.205.37 t=0 0 m=audio 19634 RTP/AVP 0 8 3 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv ------------------------------------------------------------------------ 2012-03-19 01:45:12.377734 [DEBUG] switch_core_session.c:877 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.377734 [DEBUG] switch_core_session.c:877 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.377734 [DEBUG] sofia.c:5532 Channel sofia/sipinterface_3/888@voipqso.com:5060 entering state [completing][200] 2012-03-19 01:45:12.377734 [DEBUG] sofia.c:5543 Remote SDP: v=0 o=root 1445719820 1445719820 IN IP4 8.22.205.37 s=Asterisk PBX 1.8.3.3 c=IN IP4 8.22.205.37 t=0 0 m=audio 19634 RTP/AVP 0 8 3 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 send 370 bytes to udp/[8.22.205.37]:5060 at 21:45:12.394349: ------------------------------------------------------------------------ ACK sip:888@8.22.205.37:5060 SIP/2.0 Via: SIP/2.0/UDP 184.82.20.140:5080;rport;branch=z9hG4bK4UN5UU5gXvN6g Max-Forwards: 70 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: ;tag=as71d7a24b Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717492 ACK Contact: Content-Length: 0 ------------------------------------------------------------------------ 2012-03-19 01:45:12.377734 [DEBUG] switch_core_session.c:877 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.377734 [DEBUG] switch_core_session.c:877 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:12.377734 [DEBUG] sofia.c:5532 Channel sofia/sipinterface_3/888@voipqso.com:5060 entering state [ready][200] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [PCMU:0:8000:20:64000]/[G7221:115:32000:20:48000] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [PCMU:0:8000:20:64000]/[G7221:107:16000:20:32000] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4879 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000] 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:2996 Set Codec sofia/sipinterface_3/888@voipqso.com:5060 PCMU/8000 20 ms 160 samples 64000 bits 2012-03-19 01:45:12.377734 [DEBUG] switch_core_codec.c:111 sofia/sipinterface_3/888@voipqso.com:5060 Original read codec set to PCMU:0 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:4993 Set 2833 dtmf send payload to 101 2012-03-19 01:45:12.377734 [DEBUG] sofia_glue.c:3248 AUDIO RTP [sofia/sipinterface_3/888@voipqso.com:5060] 184.82.20.140 port 28206 -> 8.22.205.37 port 19634 codec: 0 ms: 20 2012-03-19 01:45:12.377734 [DEBUG] switch_rtp.c:1661 Starting timer [soft] 160 bytes per 20ms 2012-03-19 01:45:12.397771 [DEBUG] sofia_glue.c:3512 Set 2833 dtmf send payload to 101 2012-03-19 01:45:12.397771 [DEBUG] sofia_glue.c:3518 Set 2833 dtmf receive payload to 101 2012-03-19 01:45:12.397771 [DEBUG] switch_channel.c:3190 (sofia/sipinterface_3/888@voipqso.com:5060) Callstate Change RINGING -> ACTIVE 2012-03-19 01:45:12.397771 [DEBUG] switch_channel.c:3202 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:12.397771 [NOTICE] sofia.c:6246 Channel [sofia/sipinterface_3/888@voipqso.com:5060] has been answered 2012-03-19 01:45:12.397771 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms 2012-03-19 01:45:13.517637 [DEBUG] switch_rtp.c:3210 Correct ip/port confirmed. 2012-03-19 01:45:18.397171 [DEBUG] switch_ivr_play_say.c:1678 done playing file /usr/local/freeswitch/sounds/en/us/callie/ivr/ivr-accept_reject_voicemail.wav 2012-03-19 01:45:23.397677 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms 2012-03-19 01:45:29.417110 [DEBUG] switch_ivr_play_say.c:1678 done playing file /usr/local/freeswitch/sounds/en/us/callie/ivr/ivr-accept_reject_voicemail.wav 2012-03-19 01:45:34.436636 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms 2012-03-19 01:45:40.458068 [DEBUG] switch_ivr_play_say.c:1678 done playing file /usr/local/freeswitch/sounds/en/us/callie/ivr/ivr-accept_reject_voicemail.wav 2012-03-19 01:45:42.017916 [DEBUG] switch_channel.c:2848 (sofia/sipinterface_3/888@voipqso.com:5060) Callstate Change ACTIVE -> HANGUP 2012-03-19 01:45:42.017916 [NOTICE] switch_ivr_originate.c:3182 Hangup sofia/sipinterface_3/888@voipqso.com:5060 [CS_CONSUME_MEDIA] [NO_ANSWER] 2012-03-19 01:45:42.017916 [DEBUG] switch_channel.c:2871 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [KILL] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:42.017916 [INFO] mod_dptools.c:2922 Originate Failed. Cause: NO_ANSWER EXECUTE sofia/sipinterface_1/2917@freeswitch.voipqso.com hangup() 2012-03-19 01:45:42.017916 [DEBUG] switch_channel.c:2848 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Callstate Change RINGING -> HANGUP 2012-03-19 01:45:42.017916 [NOTICE] mod_dptools.c:1121 Hangup sofia/sipinterface_1/2917@freeswitch.voipqso.com [CS_EXECUTE] [NORMAL_CLEARING] 2012-03-19 01:45:42.017916 [DEBUG] switch_channel.c:2871 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [KILL] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:2287 sofia/sipinterface_1/2917@freeswitch.voipqso.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:417 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State EXECUTE going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_HANGUP 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State HANGUP 2012-03-19 01:45:42.017916 [DEBUG] mod_sofia.c:469 Channel sofia/sipinterface_1/2917@freeswitch.voipqso.com hanging up, cause: NORMAL_CLEARING 2012-03-19 01:45:42.017916 [DEBUG] mod_sofia.c:534 Responding to INVITE with: 480 send 849 bytes to udp/[64.134.240.14]:34840 at 21:45:42.022603: ------------------------------------------------------------------------ SIP/2.0 480 Temporarily Unavailable Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPj2.WJ3I2P1CXs7eKf0J0WIbByUAHVfIOA From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: ;tag=6NyNgDKy63pec Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31862 INVITE User-Agent: Configured by 2600hz! Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Reason: Q.850;cause=16;text="NORMAL_CLEARING" Content-Length: 0 Remote-Party-ID: "9888" ;party=calling;privacy=off;screen=no ------------------------------------------------------------------------ 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:47 sofia/sipinterface_1/2917@freeswitch.voipqso.com Standard HANGUP, cause: NORMAL_CLEARING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State HANGUP going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:393 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State Change CS_HANGUP -> CS_REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:79 sofia/sipinterface_1/2917@freeswitch.voipqso.com Standard REPORTING, cause: NORMAL_CLEARING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State REPORTING going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:387 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State Change CS_REPORTING -> CS_DESTROY 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_1/2917@freeswitch.voipqso.com [BREAK] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1382 Session 1 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Locked, Waiting on external entities 2012-03-19 01:45:42.017916 [NOTICE] switch_core_session.c:1400 Session 1 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Ended 2012-03-19 01:45:42.017916 [NOTICE] switch_core_session.c:1402 Close Channel sofia/sipinterface_1/2917@freeswitch.voipqso.com [CS_DESTROY] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:491 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Callstate Change HANGUP -> DOWN 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:494 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) Running State Change CS_DESTROY 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State DESTROY 2012-03-19 01:45:42.017916 [DEBUG] mod_sofia.c:374 sofia/sipinterface_1/2917@freeswitch.voipqso.com SOFIA DESTROY 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:86 sofia/sipinterface_1/2917@freeswitch.voipqso.com Standard DESTROY 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_1/2917@freeswitch.voipqso.com) State DESTROY going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_HANGUP 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_3/888@voipqso.com:5060) State HANGUP 2012-03-19 01:45:42.017916 [DEBUG] mod_sofia.c:469 Channel sofia/sipinterface_3/888@voipqso.com:5060 hanging up, cause: NO_ANSWER 2012-03-19 01:45:42.017916 [DEBUG] mod_sofia.c:513 Sending BYE to sofia/sipinterface_3/888@voipqso.com:5060 send 597 bytes to udp/[8.22.205.37]:5060 at 21:45:42.024647: ------------------------------------------------------------------------ BYE sip:888@8.22.205.37:5060 SIP/2.0 Via: SIP/2.0/UDP 184.82.20.140:5080;rport;branch=z9hG4bK54eyXppmt5BSc Max-Forwards: 70 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: ;tag=as71d7a24b Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717493 BYE Contact: User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Reason: Q.850;cause=19;text="NO_ANSWER" Content-Length: 0 ------------------------------------------------------------------------ 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:47 sofia/sipinterface_3/888@voipqso.com:5060 Standard HANGUP, cause: NO_ANSWER 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_3/888@voipqso.com:5060) State HANGUP going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:393 (sofia/sipinterface_3/888@voipqso.com:5060) State Change CS_HANGUP -> CS_REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_3/888@voipqso.com:5060) State REPORTING 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:79 sofia/sipinterface_3/888@voipqso.com:5060 Standard REPORTING, cause: NO_ANSWER 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_3/888@voipqso.com:5060) State REPORTING going to sleep 2012-03-19 01:45:42.017916 [DEBUG] switch_core_state_machine.c:387 (sofia/sipinterface_3/888@voipqso.com:5060) State Change CS_REPORTING -> CS_DESTROY 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1182 Send signal sofia/sipinterface_3/888@voipqso.com:5060 [BREAK] 2012-03-19 01:45:42.017916 [DEBUG] switch_core_session.c:1382 Session 2 (sofia/sipinterface_3/888@voipqso.com:5060) Locked, Waiting on external entities 2012-03-19 01:45:42.037911 [NOTICE] switch_core_session.c:1400 Session 2 (sofia/sipinterface_3/888@voipqso.com:5060) Ended 2012-03-19 01:45:42.037911 [NOTICE] switch_core_session.c:1402 Close Channel sofia/sipinterface_3/888@voipqso.com:5060 [CS_DESTROY] 2012-03-19 01:45:42.037911 [DEBUG] switch_core_state_machine.c:491 (sofia/sipinterface_3/888@voipqso.com:5060) Callstate Change HANGUP -> DOWN 2012-03-19 01:45:42.037911 [DEBUG] switch_core_state_machine.c:494 (sofia/sipinterface_3/888@voipqso.com:5060) Running State Change CS_DESTROY 2012-03-19 01:45:42.037911 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_3/888@voipqso.com:5060) State DESTROY 2012-03-19 01:45:42.037911 [DEBUG] mod_sofia.c:374 sofia/sipinterface_3/888@voipqso.com:5060 SOFIA DESTROY 2012-03-19 01:45:42.037911 [DEBUG] switch_core_state_machine.c:86 sofia/sipinterface_3/888@voipqso.com:5060 Standard DESTROY 2012-03-19 01:45:42.037911 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_3/888@voipqso.com:5060) State DESTROY going to sleep recv 453 bytes from udp/[8.22.205.37]:5060 at 21:45:42.075920: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 184.82.20.140:5080;branch=z9hG4bK54eyXppmt5BSc;received=184.82.20.140;rport=5080 From: "n3glv csip" ;tag=3aj7mNecNtp0r To: ;tag=as71d7a24b Call-ID: 7b246953-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717493 BYE Server: FPBX-2.8.1(1.8.3.3) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Content-Length: 0 ------------------------------------------------------------------------ recv 427 bytes from udp/[64.134.240.14]:34840 at 21:45:42.091125: ------------------------------------------------------------------------ ACK sip:9888@freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPj2.WJ3I2P1CXs7eKf0J0WIbByUAHVfIOA Max-Forwards: 70 From: ;tag=hKTF4C4GSps4GCdB0uTQJ3hwVZeovlgH To: ;tag=6NyNgDKy63pec Call-ID: y385v8QmU7H9PwMQ2OzGiaJ82zQIiiCJ CSeq: 31862 ACK Route: Content-Length: 0 ------------------------------------------------------------------------ recv 526 bytes from udp/[64.134.240.14]:34840 at 21:45:42.618958: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPjNauiws3Tv9EPJ4c3rItWetGuv61brFDt Route: Max-Forwards: 70 From: ;tag=hW8iu3xTG0p2rl6y0oQgEFpJdXuR8K9G To: Call-ID: 9BWR55lyTqFtufCvsw5BfEPUAlbA007g CSeq: 6068 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Expires: 0 Content-Length: 0 ------------------------------------------------------------------------ send 661 bytes to udp/[64.134.240.14]:34840 at 21:45:42.619761: ------------------------------------------------------------------------ SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPjNauiws3Tv9EPJ4c3rItWetGuv61brFDt From: ;tag=hW8iu3xTG0p2rl6y0oQgEFpJdXuR8K9G To: ;tag=7yQej8313cD1Q Call-ID: 9BWR55lyTqFtufCvsw5BfEPUAlbA007g CSeq: 6068 REGISTER User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces WWW-Authenticate: Digest realm="freeswitch.voipqso.com", nonce="b5e40578-7143-11e1-91a6-698b09f7d618", algorithm=MD5, qop="auth" Content-Length: 0 ------------------------------------------------------------------------ recv 803 bytes from udp/[64.134.240.14]:34840 at 21:45:42.695207: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:34840;rport;branch=z9hG4bKPjYHcYFef9KJMgGcfZLc5sGAdxs3.9sh7d Route: Max-Forwards: 70 From: ;tag=hW8iu3xTG0p2rl6y0oQgEFpJdXuR8K9G To: Call-ID: 9BWR55lyTqFtufCvsw5BfEPUAlbA007g CSeq: 6069 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Expires: 0 Authorization: Digest username="2917", realm="freeswitch.voipqso.com", nonce="b5e40578-7143-11e1-91a6-698b09f7d618", uri="sip:freeswitch.voipqso.com", response="c90110737a667d74b52cc67602d7cceb", algorithm=MD5, cnonce="Ls3xWU7Zhcg3ew8GbViOBmFSmT7PNGL7", qop=auth, nc=00000001 Content-Length: 0 ------------------------------------------------------------------------ send 558 bytes to udp/[64.134.240.14]:34840 at 21:45:42.697215: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 64.134.240.14:34840;rport=34840;branch=z9hG4bKPjYHcYFef9KJMgGcfZLc5sGAdxs3.9sh7d From: ;tag=hW8iu3xTG0p2rl6y0oQgEFpJdXuR8K9G To: ;tag=87g7K3m50N3KK Call-ID: 9BWR55lyTqFtufCvsw5BfEPUAlbA007g CSeq: 6069 REGISTER Date: Sat, 18 Mar 2012 21:45:42 GMT User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ recv 605 bytes from udp/[64.134.240.14]:55640 at 21:45:45.709452: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 192.168.5.37:55640;rport;branch=z9hG4bKPjrIRk4DtTwycdZXCW9Ad.mljUnPeXqCSj Route: Max-Forwards: 70 From: ;tag=2wGSWOtTX1ns4zcYUMD8N70vpT8YwJGm To: Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57432 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Expires: 900 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 ------------------------------------------------------------------------ send 684 bytes to udp/[64.134.240.14]:55640 at 21:45:45.710106: ------------------------------------------------------------------------ SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.5.37:55640;rport=55640;branch=z9hG4bKPjrIRk4DtTwycdZXCW9Ad.mljUnPeXqCSj;received=64.134.240.14 From: ;tag=2wGSWOtTX1ns4zcYUMD8N70vpT8YwJGm To: ;tag=9ga0Ny58XyS6e Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57432 REGISTER User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces WWW-Authenticate: Digest realm="freeswitch.voipqso.com", nonce="b7bb95d2-7143-11e1-91a7-698b09f7d618", algorithm=MD5, qop="auth" Content-Length: 0 ------------------------------------------------------------------------ recv 882 bytes from udp/[64.134.240.14]:55640 at 21:45:46.043211: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 192.168.5.37:55640;rport;branch=z9hG4bKPjxPKIFyf300vk5KexGvSEHk5KYc9v-hnn Route: Max-Forwards: 70 From: ;tag=2wGSWOtTX1ns4zcYUMD8N70vpT8YwJGm To: Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57433 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Expires: 900 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Authorization: Digest username="2917", realm="freeswitch.voipqso.com", nonce="b7bb95d2-7143-11e1-91a7-698b09f7d618", uri="sip:freeswitch.voipqso.com", response="f6cae7475905ea12ee07e9462f7278e8", algorithm=MD5, cnonce="eCYyUKFoZFLhX9Z0LiQYoFV-AtIG-whm", qop=auth, nc=00000001 Content-Length: 0 ------------------------------------------------------------------------ send 636 bytes to udp/[64.134.240.14]:55640 at 21:45:46.045162: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.5.37:55640;rport=55640;branch=z9hG4bKPjxPKIFyf300vk5KexGvSEHk5KYc9v-hnn;received=64.134.240.14 From: ;tag=2wGSWOtTX1ns4zcYUMD8N70vpT8YwJGm To: ;tag=at3rQSpcU7FSa Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57433 REGISTER Contact: ;expires=900 Date: Sat, 18 Mar 2012 21:45:46 GMT User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ 2012-03-19 01:45:46.037528 [CONSOLE] mod_voicemail.c:3860 Event Thread Started send 915 bytes to udp/[64.134.240.14]:55640 at 21:45:46.083853: ------------------------------------------------------------------------ NOTIFY sip:2917@192.168.5.37:55640;ob SIP/2.0 Via: SIP/2.0/UDP 184.82.20.140;rport;branch=z9hG4bK52ccr9KFU2NNm Route: ;ob Max-Forwards: 70 From: ;tag=B3vHSm7Frg6Bp To: Call-ID: 8f52e922-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717509 NOTIFY Contact: User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Event: message-summary Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: terminated;reason=noresource Content-Type: application/simple-message-summary Content-Length: 74 Messages-Waiting: no Message-Account: sip:2917@freeswitch.voipqso.com ------------------------------------------------------------------------ recv 674 bytes from udp/[64.134.240.14]:55640 at 21:45:46.114397: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:55640;rport;branch=z9hG4bKPjr1G3ypIZrXeG3uh8rca47wpCfQG4u3Ll Route: Max-Forwards: 70 From: ;tag=0YZNbAiND0F0MQQ8btYvd4Aod1Q4xQxx To: Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57434 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Contact: ;expires=0 Expires: 900 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 ------------------------------------------------------------------------ send 662 bytes to udp/[64.134.240.14]:55640 at 21:45:46.115115: ------------------------------------------------------------------------ SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 64.134.240.14:55640;rport=55640;branch=z9hG4bKPjr1G3ypIZrXeG3uh8rca47wpCfQG4u3Ll From: ;tag=0YZNbAiND0F0MQQ8btYvd4Aod1Q4xQxx To: ;tag=ccpaUFrKNSvyH Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57434 REGISTER User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces WWW-Authenticate: Digest realm="freeswitch.voipqso.com", nonce="b7f9642a-7143-11e1-91a8-698b09f7d618", algorithm=MD5, qop="auth" Content-Length: 0 ------------------------------------------------------------------------ recv 307 bytes from udp/[64.134.240.14]:55640 at 21:45:46.142184: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 184.82.20.140;rport=5060;received=184.82.20.140;branch=z9hG4bK52ccr9KFU2NNm Call-ID: 8f52e922-ebe6-122f-d6b3-0708dcf9e7b4 From: ;tag=B3vHSm7Frg6Bp To: ;tag=z9hG4bK52ccr9KFU2NNm CSeq: 25717509 NOTIFY Content-Length: 0 ------------------------------------------------------------------------ recv 951 bytes from udp/[64.134.240.14]:55640 at 21:45:46.182840: ------------------------------------------------------------------------ REGISTER sip:freeswitch.voipqso.com SIP/2.0 Via: SIP/2.0/UDP 64.134.240.14:55640;rport;branch=z9hG4bKPj0gwHQNM7jZUjg.QDSXPmZZ3q70TmZozR Route: Max-Forwards: 70 From: ;tag=0YZNbAiND0F0MQQ8btYvd4Aod1Q4xQxx To: Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57435 REGISTER User-Agent: CSipSimple r1108 / picasso-13 Contact: Contact: ;expires=0 Expires: 900 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Authorization: Digest username="2917", realm="freeswitch.voipqso.com", nonce="b7f9642a-7143-11e1-91a8-698b09f7d618", uri="sip:freeswitch.voipqso.com", response="72cd3f6637dc6be24703090cadca1362", algorithm=MD5, cnonce="eCYyUKFoZFLhX9Z0LiQYoFV-AtIG-whm", qop=auth, nc=00000001 Content-Length: 0 ------------------------------------------------------------------------ send 629 bytes to udp/[64.134.240.14]:55640 at 21:45:46.184899: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 64.134.240.14:55640;rport=55640;branch=z9hG4bKPj0gwHQNM7jZUjg.QDSXPmZZ3q70TmZozR From: ;tag=0YZNbAiND0F0MQQ8btYvd4Aod1Q4xQxx To: ;tag=DNF3va9pj2jHD Call-ID: clBr26UVX9SAqtY20MGIXIiQ4YFb3ZUO CSeq: 57435 REGISTER Contact: ;expires=900 Date: Sat, 18 Mar 2012 21:45:46 GMT User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ send 888 bytes to udp/[64.134.240.14]:55640 at 21:45:46.285828: ------------------------------------------------------------------------ NOTIFY sip:2917@64.134.240.14:55640;transport=UDP;ob SIP/2.0 Via: SIP/2.0/UDP 184.82.20.140;rport;branch=z9hG4bK6B64S44jrBc8F Max-Forwards: 70 From: ;tag=ey8Uy5StFB93r To: Call-ID: 8f71ba83-ebe6-122f-d6b3-0708dcf9e7b4 CSeq: 25717509 NOTIFY Contact: User-Agent: Configured by 2600hz! Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: precondition, path, replaces Event: message-summary Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: terminated;reason=noresource Content-Type: application/simple-message-summary Content-Length: 74 Messages-Waiting: no Message-Account: sip:2917@freeswitch.voipqso.com ------------------------------------------------------------------------ recv 307 bytes from udp/[64.134.240.14]:55640 at 21:45:46.345343: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 184.82.20.140;rport=5060;received=184.82.20.140;branch=z9hG4bK6B64S44jrBc8F Call-ID: 8f71ba83-ebe6-122f-d6b3-0708dcf9e7b4 From: ;tag=ey8Uy5StFB93r To: ;tag=z9hG4bK6B64S44jrBc8F CSeq: 25717509 NOTIFY Content-Length: 0 ------------------------------------------------------------------------ freeswitch@internal>