login as: root root@yyy.yyy.yyy.174's password: Last login: Thu May 19 14:59:15 2011 [root@es1-s2-1 ~]# asterisk -R Asterisk 1.8.9.2, Copyright (C) 1999 - 2011 Digium, Inc. and others. Created by Mark Spencer Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details. This is free software, with components licensed under the GNU General Public License version 2 and other licenses; you are welcome to redistribute it under certain conditions. Type 'core show license' for details. ========================================================================= Connected to Asterisk 1.8.9.2 currently running on es1-s2-1 (pid = 26023) es1-s2-1*CLI> agi set debug on AGI Debugging Enabled AGI Tx >> 200 result=-1 AGI Tx >> HANGUP AGI Tx >> HANGUP [Mar 5 18:05:55] ERROR[14365]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/product-local-000051a8 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999533.70009 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19493519193 AGI Tx >> agi_calleridname: Port/Neun AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 4082413510 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-mailbox-exit AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1100381072 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:05:55 2012 (1330999555)" 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999533.70009) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (NOANSWER) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Tx >> HANGUP es1-s2-1*CLI> sip set debug 0n No such command 'sip set debug 0n' (type 'core show help sip set debug' for other possible commands) es1-s2-1*CLI> sip set debug on SIP Debugging enabled Really destroying SIP dialog '660691327-0-445095320@xxx.xxx.xxx.226' Method: BYE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> BYE sip:5107970546@yyy.yyy.yyy.174:5060 SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc359.7d1618c4.0 Via: SIP/2.0/UDP 192.168.1.18:5060;rport=38980;received=99.64.115.82;branch=z9hG4bK751b30c973a8bdef5.7046be914c623c754 Proxy-Require: com.nortelnetworks.firewall Proxy-Authorization: Digest username="8100102",realm="yyy.yyy.yyy.166",nonce="4f55709d0000e5e08068d152ca29bd40db493ffe687ad1bf",uri="sip:5107970546@yyy.yyy.yyy.174:5060",response="8e2237bc4a478fae1d604d088e33a0bd" Max-Forwards: 69 From: "Stephen" ;tag=48cde35d36 To: "5107970546" ;tag=as114f291a Call-ID: ee333232805a9c5a CSeq: 23028 BYE Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO Allow-Events: talk, hold, conference, LocalModeStatus Supported: gruu, path, timer User-Agent: Aastra 57i/2.6.0.66 Content-Length: 0 X-Enswitch-RURI: sip:5107970546@yyy.yyy.yyy.174:5060 X-Enswitch-Source: 99.64.115.82:38980 <-------------> --- (18 headers 0 lines) --- Sending to yyy.yyy.yyy.166:5060 (NAT) Scheduling destruction of SIP dialog 'ee333232805a9c5a' in 32000 ms (Method: BYE) <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc359.7d1618c4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP 192.168.1.18:5060;rport=38980;received=99.64.115.82;branch=z9hG4bK751b30c973a8bdef5.7046be914c623c754 Record-Route: From: "Stephen" ;tag=48cde35d36 To: "5107970546" ;tag=as114f291a Call-ID: ee333232805a9c5a CSeq: 23028 BYE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Content-Length: 0 <------------> AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/product-local-0000519b AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999423.69960 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19254004006 AGI Tx >> agi_calleridname: Stephen AGI Tx >> agi_callingpres: 1 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 5107970546 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1099152272 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:28 2012 (1330999588)" 9 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999423.69960) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 (155) AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (ANSWER) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Tx >> HANGUP Scheduling destruction of SIP dialog '577874860febd6287a485ee51d7b5db0@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to set_destination: set destination to xxx.xxx.xxx.30:5060 Reliably Transmitting (no NAT) to xxx.xxx.xxx.30:5060: BYE sip:15107970546@xxx.xxx.xxx.30:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK16de067f Route: Max-Forwards: 70 From: "Stephen" ;tag=as7def0518 To: ;tag=sansay50077750rdb16225 Call-ID: 577874860febd6287a485ee51d7b5db0@yyy.yyy.yyy.174:5060 CSeq: 103 BYE User-Agent: Enswitch X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 --- AGI Tx >> 200 result=-1 AGI Tx >> HANGUP AGI Tx >> HANGUP [Mar 5 18:06:29] ERROR[14044]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe <--- SIP read from UDP:xxx.xxx.xxx.30:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK16de067f To: ;tag=sansay50077750rdb16225 From: "Stephen" ;tag=as7def0518 Call-ID: 577874860febd6287a485ee51d7b5db0@yyy.yyy.yyy.174:5060 CSeq: 103 BYE Content-Length: 0 <-------------> --- (7 headers 0 lines) --- Really destroying SIP dialog '577874860febd6287a485ee51d7b5db0@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:38070 ---> OPTIONS sip:yyy.yyy.yyy.174:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.166:38391;branch=z9hG4bK.024c83f5;rport;alias From: sip:sipsak@yyy.yyy.yyy.166:38391;tag=21f64aab To: sip:yyy.yyy.yyy.174:5060 Call-ID: 569789099@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Contact: sip:sipsak@yyy.yyy.yyy.166:38391 Content-Length: 0 Max-Forwards: 70 User-Agent: sipsak 0.9.6 Accept: text/plain <-------------> --- (11 headers 0 lines) --- Looking for s in from-external (domain yyy.yyy.yyy.174) <--- Transmitting (NAT) to yyy.yyy.yyy.166:38070 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166:38391;branch=z9hG4bK.024c83f5;alias;received=yyy.yyy.yyy.166;rport=38070 From: sip:sipsak@yyy.yyy.yyy.166:38391;tag=21f64aab To: sip:yyy.yyy.yyy.174:5060;tag=as297f9e04 Call-ID: 569789099@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 <------------> Scheduling destruction of SIP dialog '569789099@yyy.yyy.yyy.166' in 32000 ms (Method: OPTIONS) Really destroying SIP dialog '709051213@yyy.yyy.yyy.166' Method: OPTIONS es1-s2-1*CLI> core set verbose 9 Verbosity was 0 and is now 9 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> INVITE sip:4159224339@yyy.yyy.yyy.174:5060;transport=udp SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: To: From: ;tag=sansay50084464rdb14528 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Contact: Supported: timer Session-Expires: 1800;refresher=uac Min-SE: 90 Remote-Party-ID: ;privacy=off Max-Forwards: 15 Content-Type: application/sdp Content-Length: 276 X-Enswitch-RURI: sip:4159224339@yyy.yyy.yyy.166:5060 X-Enswitch-Source: xxx.xxx.xxx.30:5060 X-Enswitch-External: yes v=0 o=Sansay-VSXi 188 1 IN IP4 xxx.xxx.xxx.30 s=Session Controller c=IN IP4 208.93.47.132 t=0 0 m=audio 9438 RTP/AVP 0 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=sendrecv a=maxptime:20 <-------------> --- (20 headers 13 lines) --- == Using UDPTL CoS mark 5 Sending to yyy.yyy.yyy.166:5060 (NAT) Using INVITE request as basis request - 660692327-0-445158760@xxx.xxx.xxx.226 Found peer 'product-local' for '19253212508' from yyy.yyy.yyy.166:5060 == Using SIP RTP CoS mark 5 Found RTP audio format 0 Found RTP audio format 18 Found RTP audio format 101 Found audio description format PCMU for ID 0 Found audio description format G729 for ID 18 Found audio description format telephone-event for ID 101 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x104 (ulaw|g729)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x104 (ulaw|g729) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 208.93.47.132:9438 Peer doesn't provide video Looking for 4159224339 in from-internal (domain yyy.yyy.yyy.174) list_route: hop: list_route: hop: <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: Record-Route: From: ;tag=sansay50084464rdb14528 To: Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Length: 0 <------------> -- Executing [4159224339@from-internal:1] AGI("SIP/product-local-000051b1", "agi://127.0.0.1/product?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: product?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/product?stype=internal AGI Tx >> agi_channel: SIP/product-local-000051b1 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999596.70050 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 4159224339 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 4159224339 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1099152272 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?stype=internal: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-CALLID "1330999596.70050" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.468 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.469 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-Source) AGI Tx >> 200 result=1 (xxx.xxx.xxx.30:5060) AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-External) AGI Tx >> 200 result=1 (yes) AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Resolving type '', number '4159224339', old '', forward 1 for channel SIP/product-local-000051b1" 5 > agi://127.0.0.1/product?stype=internal: Resolving type '', number '4159224339', old '', forward 1 for channel SIP/product-local-000051b1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DIVERSION "4159224339" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type 'huntgroup', number '810', old '', forward 2 for channel SIP/product-local-000051b1" 5 > agi://127.0.0.1/product?stype=internal: Resolving type 'huntgroup', number '810', old '', forward 2 for channel SIP/product-local-000051b1 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Customer 195 has 86400 inbound seconds available." 9 > agi://127.0.0.1/product?stype=internal: Customer 195 has 86400 inbound seconds available. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.530 PST. AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70050, external:19253212508 - huntgroup:810." 9 > agi://127.0.0.1/product?stype=internal: Writing entry to active table for 1330999596.70050, external:19253212508 - huntgroup:810. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE SIP_HEADER(Call-ID) AGI Tx >> 200 result=1 (660692327-0-445158760@xxx.xxx.xxx.226) AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 () AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.551 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CALLERID-EXTERNAL "19253212508" AGI Tx >> 200 result=1 AGI Rx << EXEC Ringing "" -- AGI Script Executing Application: (Ringing) Options: () <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Length: 0 <------------> AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-1 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-1 "4339101" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-2 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-2 "4339102" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-3 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-3 "4339103" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-4 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-4 "4339104" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-5 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-5 "4339105" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-6 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-6 "4339106" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-STYPE "huntgroup" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-SNUMBER "810" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CTYPE-7 "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CNUMBER-7 "4339107" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/1@product-call-exten/n&Local/2@product-call-exten/n&Local/3@product-call-exten/n&Local/4@product-call-exten/n&Local/5@product-call-exten/n&Local/6@product-call-exten/n&Local/7@product-call-exten/n,30,oir" -- AGI Script Executing Application: (Dial) Options: (Local/1@product-call-exten/n&Local/2@product-call-exten/n&Local/3@product-call-exten/n&Local/4@product-call-exten/n&Local/5@product-call-exten/n&Local/6@product-call-exten/n&Local/7@product-call-exten/n,30,oir) -- Called Local/1@product-call-exten/n -- Called Local/2@product-call-exten/n -- Executing [2@product-call-exten:1] AGI("Local/2@product-call-exten-455e;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1") in new stack -- Called Local/3@product-call-exten/n -- Executing [1@product-call-exten:1] AGI("Local/1@product-call-exten-5325;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1 AGI Tx >> agi_channel: Local/1@product-call-exten-5325;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70052 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: 1 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 Local/1@product-call-exten-5325;2>AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1100381072 AGI Tx >> -- Executing [3@product-call-exten:1] AGI("Local/3@product-call-exten-6488;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1") in new stack -- Called Local/4@product-call-exten/n -- Called Local/5@product-call-exten/n -- Called Local/6@product-call-exten/n -- Executing [4@product-call-exten:1] AGI("Local/4@product-call-exten-5720;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1 -- Called Local/7@product-call-exten/n AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1 AGI Tx >> agi_channel: Local/4@product-call-exten-5720;2 AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1 <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Length: 0 <------------> AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70058 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: 4 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1131215760 AGI Tx >> AGI Tx >> agi_channel: Local/2@product-call-exten-455e;2 AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70054 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Tx >> agi_network: yes AGI Tx >> 200 result=1 -- Executing [7@product-call-exten:1] AGI("Local/7@product-call-exten-b239;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1") in new stack -- Executing [5@product-call-exten:1] AGI("Local/5@product-call-exten-d996;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1") in new stack AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1 AGI Tx >> agi_network: yes AGI Tx >> agi_network: yes AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1 AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1 AGI Tx >> agi_channel: Local/5@product-call-exten-d996;2 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1 AGI Tx >> agi_channel: Local/7@product-call-exten-b239;2 AGI Tx >> agi_language: en -- Executing [6@product-call-exten:1] AGI("Local/6@product-call-exten-b5d1;2", "agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1") in new stack AGI Tx >> agi_type: Local AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_language: en AGI Tx >> agi_channel: Local/3@product-call-exten-6488;2 AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70060 AGI Tx >> agi_language: en AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70056 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_network: yes AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: 2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_priority: 1 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_accountcode: AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_threadid: 1097026448 AGI Tx >> agi_callington: 0 AGI Tx >> AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: 3 AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 AGI Tx >> agi_priority: 1 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1107655568 AGI Tx >> AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Tx >> agi_callerid: 19253212508 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> agi_calleridname: unknown AGI Tx >> 200 result=1 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Tx >> agi_network_script: product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1 AGI Tx >> agi_request: agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_channel: Local/6@product-call-exten-b5d1;2 AGI Tx >> agi_rdnis: unknown AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70062 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_uniqueid: 1330999596.70064 AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_extension: 5 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1107409808 AGI Tx >> AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 Local/6@product-call-exten-b5d1;2>AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: 6 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1122155408 AGI Tx >> AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=0 AGI Tx >> 200 result=1 (4159224339) AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 (4159224339) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Tx >> 200 result=1 Channel will hangup at 2012-03-06 18:06:36.589 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Rx << GET VARIABLE PRODUCT-CUTOFF Channel will hangup at 2012-03-06 18:06:36.590 PST. AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 (86400) AGI Tx >> agi_callerid: 19253212508 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Rx << GET VARIABLE PRODUCT-CUTOFF Channel will hangup at 2012-03-06 18:06:36.590 PST. AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 (86400) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.590 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Tx >> agi_calleridname: unknown AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Tx >> agi_callingpres: 0 AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Tx >> 200 result=1 (19253212508) AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Tx >> agi_callingtns: 0 AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Tx >> 200 result=1 (19253212508) AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Rx << VERBOSE "Resolving type 'phone', number '4339103', old '', forward 1 for channel Local/3@product-call-exten-6488;2" 5 AGI Tx >> agi_context: product-call-exten > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1: Resolving type 'phone', number '4339103', old '', forward 1 for channel Local/3@product-call-exten-6488;2 AGI Tx >> 200 result=1 AGI Tx >> agi_extension: 7 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1129249680 AGI Rx << VERBOSE "Resolving type 'phone', number '4339102', old '', forward 1 for channel Local/2@product-call-exten-455e;2" 5 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1: Resolving type 'phone', number '4339102', old '', forward 1 for channel Local/2@product-call-exten-455e;2 AGI Tx >> 200 result=1 AGI Tx >> AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 (4159224339) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 (4159224339) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.607 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.608 PST. AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.609 PST. AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.610 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 AGI Rx << GET VARIABLE DUMMY > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 () AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Tx >> 200 result=1 (19253212508) AGI Tx >> 200 result=1 (19253212508) AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << VERBOSE "Resolving type 'phone', number '4339101', old '', forward 1 for channel Local/1@product-call-exten-5325;2" 5 AGI Rx << VERBOSE "Resolving type 'phone', number '4339104', old '', forward 1 for channel Local/4@product-call-exten-5720;2" 5 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1: Resolving type 'phone', number '4339101', old '', forward 1 for channel Local/1@product-call-exten-5325;2 AGI Tx >> 200 result=1 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1: Resolving type 'phone', number '4339104', old '', forward 1 for channel Local/4@product-call-exten-5720;2 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70056, huntgroup:810 - phone:4339103." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339103&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70056, huntgroup:810 - phone:4339103. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 () AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:36 2012 (1330999596)" 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1: AGI starting at Mon Mar 5 18:06:36 2012 (1330999596) AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 (4159224339) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.634 PST. AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70054, huntgroup:810 - phone:4339102." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70054, huntgroup:810 - phone:4339102. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.637 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.638 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70052, huntgroup:810 - phone:4339101." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70052, huntgroup:810 - phone:4339101. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339103" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE CALLERID(name) AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Tx >> 200 result=1 (19253212508) AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 (4159224339) AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70058, huntgroup:810 - phone:4339104." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70058, huntgroup:810 - phone:4339104. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type 'phone', number '4339105', old '', forward 1 for channel Local/5@product-call-exten-d996;2" 5 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1: Resolving type 'phone', number '4339105', old '', forward 1 for channel Local/5@product-call-exten-d996;2 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Rx << SET VARIABLE CALLERID(number) "19253212508" Channel will hangup at 2012-03-06 18:06:36.649 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.650 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Rx << GET VARIABLE PRODUCT-SCREEN Channel will hangup at 2012-03-06 18:06:36.651 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE DUMMY "" AGI Rx << GET VARIABLE CALLERID(name) AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=1 () AGI Tx >> 200 result=1 AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DUMMY AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=1 () AGI Tx >> 200 result=1 (4159224339) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=1 AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 (19253212508) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" Channel will hangup at 2012-03-06 18:06:36.655 PST. AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.656 PST. AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type 'phone', number '4339107', old '', forward 1 for channel Local/7@product-call-exten-b239;2" 5 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1: Resolving type 'phone', number '4339107', old '', forward 1 for channel Local/7@product-call-exten-b239;2 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.659 PST. AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339102" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=0 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLERID-EXTERNAL AGI Tx >> 200 result=1 (19253212508) AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.663 PST. AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type 'phone', number '4339106', old '', forward 1 for channel Local/6@product-call-exten-b5d1;2" 5 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1: Resolving type 'phone', number '4339106', old '', forward 1 for channel Local/6@product-call-exten-b5d1;2 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339101" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339104" AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70060, huntgroup:810 - phone:4339105." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70060, huntgroup:810 - phone:4339105. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339103" AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/4339103@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339103@product-phone/n,3600,o) -- Called Local/4339103@product-phone/n -- Executing [4339103@product-phone:1] GotoIf("Local/4339103@product-phone-5590;2", "0?3") in new stack -- Executing [4339103@product-phone:2] SetMusicOnHold("Local/4339103@product-phone-5590;2", "46") in new stack -- Executing [4339103@product-phone:3] Dial("Local/4339103@product-phone-5590;2", "SIP/4339103@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 () == Using SIP RTP CoS mark 5 Audio is at 18596 Video is at yyy.yyy.yyy.174:16098 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339103@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK77106c47;rport Max-Forwards: 70 From: "19253212508" ;tag=as77d6d1ee To: Contact: Call-ID: 4ef02d103b0f112908d82d39725910be@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1814426875 1814426875 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 18596 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 16098 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339103@yyy.yyy.yyy.166:5060 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK77106c47;rport=5060 From: "19253212508" ;tag=as77d6d1ee To: Call-ID: 4ef02d103b0f112908d82d39725910be@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3907 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339103@yyy.yyy.yyy.166:5060 out_uri=sip:4339103@192.168.0.14:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.689 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339102" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339101" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339105" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339104" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/4339102@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339102@product-phone/n,3600,o) -- Called Local/4339102@product-phone/n -- Executing [4339102@product-phone:1] GotoIf("Local/4339102@product-phone-e98b;2", "0?3") in new stack -- Executing [4339102@product-phone:2] SetMusicOnHold("Local/4339102@product-phone-e98b;2", "46") in new stack -- Executing [4339102@product-phone:3] Dial("Local/4339102@product-phone-e98b;2", "SIP/4339102@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70064, huntgroup:810 - phone:4339107." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70064, huntgroup:810 - phone:4339107. AGI Tx >> 200 result=1 == Using SIP RTP CoS mark 5 Audio is at 12006 Video is at yyy.yyy.yyy.174:18050 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339102@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK00f0577e;rport Max-Forwards: 70 From: "19253212508" ;tag=as6cefe95d To: Contact: Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 381 v=0 o=root 446984546 446984546 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 12006 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 18050 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339102@yyy.yyy.yyy.166:5060 AGI Rx << EXEC Dial "Local/4339101@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339101@product-phone/n,3600,o) -- Called Local/4339101@product-phone/n -- Executing [4339101@product-phone:1] GotoIf("Local/4339101@product-phone-0983;2", "0?3") in new stack -- Executing [4339101@product-phone:2] SetMusicOnHold("Local/4339101@product-phone-0983;2", "46") in new stack -- Executing [4339101@product-phone:3] Dial("Local/4339101@product-phone-0983;2", "SIP/4339101@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << EXEC Dial "Local/4339104@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339104@product-phone/n,3600,o) AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 -- Called Local/4339104@product-phone/n <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK00f0577e;rport=5060 From: "19253212508" ;tag=as6cefe95d To: Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3917 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339102@yyy.yyy.yyy.166:5060 out_uri=sip:4339102@192.168.0.253:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- -- Executing [4339104@product-phone:1] GotoIf("Local/4339104@product-phone-7278;2", "0?3") in new stack -- Executing [4339104@product-phone:2] SetMusicOnHold("Local/4339104@product-phone-7278;2", "46") in new stack -- Executing [4339104@product-phone:3] Dial("Local/4339104@product-phone-7278;2", "SIP/4339104@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Writing entry to active table for 1330999596.70062, huntgroup:810 - phone:4339106." 9 > agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1: Writing entry to active table for 1330999596.70062, huntgroup:810 - phone:4339106. AGI Tx >> 200 result=1 == Using SIP RTP CoS mark 5 Audio is at 18928 Video is at yyy.yyy.yyy.174:10422 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339101@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1422b9bf;rport Max-Forwards: 70 From: "19253212508" ;tag=as50985e4c To: Contact: Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1373443563 1373443563 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 18928 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 10422 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339101@yyy.yyy.yyy.166:5060 == Using SIP RTP CoS mark 5 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1422b9bf;rport=5060 From: "19253212508" ;tag=as50985e4c To: Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3919 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339101@yyy.yyy.yyy.166:5060 out_uri=sip:4339101@192.168.0.15:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- Audio is at 17410 Video is at yyy.yyy.yyy.174:14282 Adding codec 0x4 (ulaw) to SDP AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 () Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339104@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2dbf2d95;rport Max-Forwards: 70 From: "19253212508" ;tag=as62dfaba6 To: Contact: Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 381 v=0 o=root 133877764 133877764 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 17410 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 14282 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339104@yyy.yyy.yyy.166:5060 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2dbf2d95;rport=5060 From: "19253212508" ;tag=as62dfaba6 To: Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3917 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339104@yyy.yyy.yyy.166:5060 out_uri=sip:4339104@192.168.0.16:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 () AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.718 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339105" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339107" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:36.724 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "46" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "46" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/4339105@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339105@product-phone/n,3600,o) -- Called Local/4339105@product-phone/n -- Executing [4339105@product-phone:1] GotoIf("Local/4339105@product-phone-ae9b;2", "0?3") in new stack -- Executing [4339105@product-phone:2] SetMusicOnHold("Local/4339105@product-phone-ae9b;2", "46") in new stack -- Executing [4339105@product-phone:3] Dial("Local/4339105@product-phone-ae9b;2", "SIP/4339105@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "4339106" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 == Using SIP RTP CoS mark 5 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 Audio is at 17148 Video is at yyy.yyy.yyy.174:12618 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339105@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK43f36368;rport Max-Forwards: 70 From: "19253212508" ;tag=as4a1cacf8 To: Contact: Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1538839580 1538839580 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 17148 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 12618 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339105@yyy.yyy.yyy.166:5060 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3919 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339105@yyy.yyy.yyy.166:5060 out_uri=sip:4339105@192.168.0.17:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- AGI Rx << SET VARIABLE CALLERID(number) "19253212508" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "195" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER06 "Diversion: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339107" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ot" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "4339106" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/4339107@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339107@product-phone/n,3600,o) -- Called Local/4339107@product-phone/n -- Executing [4339107@product-phone:1] GotoIf("Local/4339107@product-phone-f173;2", "0?3") in new stack -- Executing [4339107@product-phone:2] SetMusicOnHold("Local/4339107@product-phone-f173;2", "46") in new stack -- Executing [4339107@product-phone:3] Dial("Local/4339107@product-phone-f173;2", "SIP/4339107@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 AGI Rx << EXEC Dial "Local/4339106@product-phone/n,3600,o" -- AGI Script Executing Application: (Dial) Options: (Local/4339106@product-phone/n,3600,o) -- Called Local/4339106@product-phone/n -- Executing [4339106@product-phone:1] GotoIf("Local/4339106@product-phone-67d7;2", "0?3") in new stack -- Executing [4339106@product-phone:2] SetMusicOnHold("Local/4339106@product-phone-67d7;2", "46") in new stack -- Executing [4339106@product-phone:3] Dial("Local/4339106@product-phone-67d7;2", "SIP/4339106@yyy.yyy.yyy.166:5060,3600,ot") in new stack == Using UDPTL CoS mark 5 == Using SIP RTP CoS mark 5 Audio is at 17908 Video is at yyy.yyy.yyy.174:16384 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP == Using SIP RTP CoS mark 5 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339107@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK09313fc5;rport Max-Forwards: 70 From: "19253212508" ;tag=as7d7e2d50 To: Contact: Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1233570844 1233570844 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 17908 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 16384 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339107@yyy.yyy.yyy.166:5060 Audio is at 18686 Video is at yyy.yyy.yyy.174:19028 Adding codec 0x4 (ulaw) to SDP Adding codec 0x1000 (g722) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:4339106@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2d6f7443;rport Max-Forwards: 70 From: "19253212508" ;tag=as7b7a5697 To: Contact: Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Diversion: Content-Type: application/sdp Content-Length: 381 v=0 o=root 358434796 358434796 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 18686 RTP/AVP 0 9 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:9 G722/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 19028 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/4339106@yyy.yyy.yyy.166:5060 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK09313fc5;rport=5060 From: "19253212508" ;tag=as7d7e2d50 To: Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3912 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339107@yyy.yyy.yyy.166:5060 out_uri=sip:4339107@192.168.0.243:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2d6f7443;rport=5060 From: "19253212508" ;tag=as7b7a5697 To: Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3907 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339106@yyy.yyy.yyy.166:5060 out_uri=sip:4339106@192.168.0.244:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK77106c47;rport=5060 Record-Route: From: "19253212508" ;tag=as77d6d1ee To: ;tag=472309027 Call-ID: 4ef02d103b0f112908d82d39725910be@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.140 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b2 is ringing -- Local/4339103@product-phone-5590;1 is ringing -- Local/3@product-call-exten-6488;1 is ringing <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Length: 0 <------------> <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK2dbf2d95;rport=5060 Record-Route: From: "19253212508" ;tag=as62dfaba6 To: ;tag=306966694 Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.61.0.80 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b5 is ringing -- Local/4339104@product-phone-7278;1 is ringing -- Local/4@product-call-exten-5720;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK00f0577e;rport=5060 Record-Route: From: "19253212508" ;tag=as6cefe95d To: ;tag=401817453 Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.61.0.80 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b3 is ringing -- Local/4339102@product-phone-e98b;1 is ringing -- Local/2@product-call-exten-455e;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK1422b9bf;rport=5060 Record-Route: From: "19253212508" ;tag=as50985e4c To: ;tag=56573007 Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.61.0.80 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b4 is ringing -- Local/4339101@product-phone-0983;1 is ringing -- Local/1@product-call-exten-5325;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 Record-Route: From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.140 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b6 is ringing -- Local/4339105@product-phone-ae9b;1 is ringing -- Local/5@product-call-exten-d996;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK2d6f7443;rport=5060 Record-Route: From: "19253212508" ;tag=as7b7a5697 To: ;tag=1077816014 Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.61.0.80 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b8 is ringing -- Local/4339106@product-phone-67d7;1 is ringing -- Local/6@product-call-exten-b5d1;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK09313fc5;rport=5060 Record-Route: From: "19253212508" ;tag=as7d7e2d50 To: ;tag=1774851890 Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.61.0.80 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051b7 is ringing -- Local/4339107@product-phone-f173;1 is ringing -- Local/7@product-call-exten-b239;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:48308 ---> OPTIONS sip:yyy.yyy.yyy.174:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.166:44585;branch=z9hG4bK.10cd10f9;rport;alias From: sip:sipsak@yyy.yyy.yyy.166:44585;tag=59301d23 To: sip:yyy.yyy.yyy.174:5060 Call-ID: 1496325411@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Contact: sip:sipsak@yyy.yyy.yyy.166:44585 Content-Length: 0 Max-Forwards: 70 User-Agent: sipsak 0.9.6 Accept: text/plain <-------------> --- (11 headers 0 lines) --- Looking for s in from-external (domain yyy.yyy.yyy.174) <--- Transmitting (NAT) to yyy.yyy.yyy.166:48308 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166:44585;branch=z9hG4bK.10cd10f9;alias;received=yyy.yyy.yyy.166;rport=48308 From: sip:sipsak@yyy.yyy.yyy.166:44585;tag=59301d23 To: sip:yyy.yyy.yyy.174:5060;tag=as2b265922 Call-ID: 1496325411@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 <------------> Scheduling destruction of SIP dialog '1496325411@yyy.yyy.yyy.166' in 32000 ms (Method: OPTIONS) Really destroying SIP dialog '348825065@yyy.yyy.yyy.166' Method: OPTIONS <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK77106c47;rport=5060 Record-Route: From: "19253212508" ;tag=as77d6d1ee To: ;tag=472309027 Call-ID: 4ef02d103b0f112908d82d39725910be@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Content-Type: application/sdp Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 316 v=0 o=- 20021 20021 IN IP4 192.168.0.14 s=SDP data c=IN IP4 50.0.205.141 t=0 0 m=audio 11780 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=sendrecv a=ptime:20 a=fmtp:101 0-15 a=rtpmap:101 telephone-event/8000 m=video 0 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv a=direction:active a=oldmediaip:192.168.0.14 <-------------> --- (12 headers 16 lines) --- Found RTP audio format 0 Found RTP audio format 101 Found audio description format PCMU for ID 0 Found audio description format telephone-event for ID 101 [Mar 5 18:06:41] WARNING[26047]: chan_sip.c:8942 process_sdp: Unsupported SDP media type in offer: video 0 RTP/AVP 99 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x4 (ulaw)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x4 (ulaw) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 50.0.205.141:11780 Peer doesn't provide video set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339103@50.0.205.141:5062 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1d350ebc;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as77d6d1ee To: ;tag=472309027 Contact: Call-ID: 4ef02d103b0f112908d82d39725910be@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- -- SIP/yyy.yyy.yyy.166:5060-000051b2 answered Local/4339103@product-phone-5590;2 -- Local/4339103@product-phone-5590;1 answered Local/3@product-call-exten-6488;2 -- Local/3@product-call-exten-6488;1 answered SIP/product-local-000051b1 AGI Tx >> 200 result=-1 AGI Tx >> HANGUP AGI Tx >> 200 result=-1 AGI Tx >> 200 result=-1 AGI Tx >> HANGUP AGI Tx >> 200 result=-1 Scheduling destruction of SIP dialog '6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) AGI Tx >> HANGUP Scheduling destruction of SIP dialog '6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to AGI Tx >> 200 result=-1 AGI Tx >> HANGUP AGI Tx >> 200 result=-1 AGI Tx >> HANGUP Scheduling destruction of SIP dialog '1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339106@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2d6f7443;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as7b7a5697 To: Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) == Spawn extension (product-phone, 4339106, 3) exited non-zero on 'Local/4339106@product-phone-67d7;2' Audio is at 10088 Adding codec 0x4 (ulaw) to SDP Adding codec 0x100 (g729) to SDP Adding non-codec 0x1 (telephone-event) to SDP AGI Tx >> HANGUP Scheduling destruction of SIP dialog '26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) <--- Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528 Record-Route: Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Type: application/sdp Content-Length: 285 v=0 o=root 634336327 634336327 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 t=0 0 m=audio 10088 RTP/AVP 0 18 101 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv <------------> set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339104@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2dbf2d95;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as62dfaba6 To: Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) Scheduling destruction of SIP dialog '26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339107@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK09313fc5;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as7d7e2d50 To: Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) Scheduling destruction of SIP dialog '6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) == Spawn extension (product-phone, 4339104, 3) exited non-zero on 'Local/4339104@product-phone-7278;2' set_destination: set destination to yyy.yyy.yyy.166:5060 == Spawn extension (product-phone, 4339107, 3) exited non-zero on 'Local/4339107@product-phone-f173;2' Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339105@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK43f36368;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as4a1cacf8 To: Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) == Spawn extension (product-phone, 4339105, 3) exited non-zero on 'Local/4339105@product-phone-ae9b;2' set_destination: Parsing for address/port to send to set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339102@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK00f0577e;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as6cefe95d To: Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) == Spawn extension (product-phone, 4339102, 3) exited non-zero on 'Local/4339102@product-phone-e98b;2' set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: CANCEL sip:4339101@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1422b9bf;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as50985e4c To: Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL User-Agent: Enswitch Content-Length: 0 --- Scheduling destruction of SIP dialog '36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) == Spawn extension (product-phone, 4339101, 3) exited non-zero on 'Local/4339101@product-phone-0983;2' <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2d6f7443;rport=5060 From: "19253212508" ;tag=as7b7a5697 To: ;tag=926e762569b6d426baf655e9094a362b-3e80 Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3909 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339106@yyy.yyy.yyy.166:5060 out_uri=sip:4339106@192.168.0.244:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK09313fc5;rport=5060 From: "19253212508" ;tag=as7d7e2d50 To: ;tag=926e762569b6d426baf655e9094a362b-b41b Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3907 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339107@yyy.yyy.yyy.166:5060 out_uri=sip:4339107@192.168.0.243:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK00f0577e;rport=5060 From: "19253212508" ;tag=as6cefe95d To: ;tag=926e762569b6d426baf655e9094a362b-76bd Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3912 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339102@yyy.yyy.yyy.166:5060 out_uri=sip:4339102@192.168.0.253:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=926e762569b6d426baf655e9094a362b-f0ea Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3913 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339105@yyy.yyy.yyy.166:5060 out_uri=sip:4339105@192.168.0.17:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2dbf2d95;rport=5060 From: "19253212508" ;tag=as62dfaba6 To: ;tag=926e762569b6d426baf655e9094a362b-4d06 Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3919 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339104@yyy.yyy.yyy.166:5060 out_uri=sip:4339104@192.168.0.16:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 canceling Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1422b9bf;rport=5060 From: "19253212508" ;tag=as50985e4c To: ;tag=926e762569b6d426baf655e9094a362b-31e7 Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 CANCEL Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3906 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:4339101@yyy.yyy.yyy.166:5060 out_uri=sip:4339101@192.168.0.15:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339102&append_callerid=&loopback=1 completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14512]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (product-call-exten, 2, 1) exited non-zero on 'Local/2@product-call-exten-455e;2' -- Executing [h@product-call-exten:1] AGI("Local/2@product-call-exten-455e;2", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/2@product-call-exten-455e;2 AGI Tx >> agi_language: en -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339105&append_callerid=&loopback=1 completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14516]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (product-call-exten, 5, 1) exited non-zero on 'Local/5@product-call-exten-d996;2' -- Executing [h@product-call-exten:1] AGI("Local/5@product-call-exten-d996;2", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_type: Local AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/5@product-call-exten-d996;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70060 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1107409808 AGI Tx >> AGI Tx >> agi_uniqueid: 1330999596.70054 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1097026448 AGI Tx >> -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339107&append_callerid=&loopback=1 completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14518]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (product-call-exten, 7, 1) exited non-zero on 'Local/7@product-call-exten-b239;2' -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339104&append_callerid=&loopback=1 completed, returning 4 -- Executing [h@product-call-exten:1] AGI("Local/7@product-call-exten-b239;2", "agi://127.0.0.1/end") in new stack AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14515]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 == Spawn extension (product-call-exten, 4, 1) exited non-zero on 'Local/4@product-call-exten-5720;2' -- Executing [h@product-call-exten:1] AGI("Local/4@product-call-exten-5720;2", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339106&append_callerid=&loopback=1 completed, returning 4 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) AGI Tx >> 200 result=1 AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/7@product-call-exten-b239;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70064 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1129249680 AGI Tx >> AGI Tx >> agi_network_script: end AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 AGI Tx >> agi_request: agi://127.0.0.1/end > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Tx >> agi_channel: Local/4@product-call-exten-5720;2 AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14517]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (product-call-exten, 6, 1) exited non-zero on 'Local/6@product-call-exten-b5d1;2' AGI Rx << SET VARIABLE CHANNEL(language) "en" -- Executing [h@product-call-exten:1] AGI("Local/6@product-call-exten-b5d1;2", "agi://127.0.0.1/end") in new stack AGI Tx >> 200 result=1 AGI Tx >> agi_network: yes AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70058 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/6@product-call-exten-b5d1;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70062 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1122155408 AGI Tx >> AGI Tx >> agi_callington: 0 AGI Tx >> 200 result=1 (1330999596.70050) AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1131215760 AGI Tx >> AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE ANSWEREDTIME AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 AGI Rx << GET VARIABLE DIALSTATUS > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) -- AGI Script agi://127.0.0.1/product?scustomer=195&stype=huntgroup&snumber=810&ctype=phone&cnumber=4339101&append_callerid=&loopback=1 completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:06:41] ERROR[14511]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (product-call-exten, 1, 1) exited non-zero on 'Local/1@product-call-exten-5325;2' -- Executing [h@product-call-exten:1] AGI("Local/1@product-call-exten-5325;2", "agi://127.0.0.1/end") in new stack AGI Tx >> 200 result=1 AGI Tx >> agi_network: yes AGI Tx >> 200 result=1 (CANCEL) AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/1@product-call-exten-5325;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999596.70052 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 19253212508 AGI Tx >> agi_calleridname: unknown AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: product-call-exten AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1100381072 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=0 AGI Tx >> 200 result=1 (CANCEL) AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 Local/4@product-call-exten-5720;2>AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (CANCEL) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL Local/4@product-call-exten-5720;2>AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (CANCEL) AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE DIALSTATUS AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=1 (CANCEL) AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:41 2012 (1330999601)" 9 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:06:41 2012 (1330999601) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999596.70050) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (CANCEL) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK2d6f7443;rport=5060 From: "19253212508" ;tag=as7b7a5697 To: ;tag=1077816014 Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.61.0.80 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339106@50.0.205.141:1063 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2d6f7443;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as7b7a5697 To: ;tag=1077816014 Contact: Call-ID: 1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '1b0ab340130231df3d068ce939685251@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK1422b9bf;rport=5060 From: "19253212508" ;tag=as50985e4c To: ;tag=56573007 Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.61.0.80 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339101@50.0.205.141:1062 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1422b9bf;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as50985e4c To: ;tag=56573007 Contact: Call-ID: 36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '36bd9f89014a823f48dd99e77ce8b6af@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK00f0577e;rport=5060 From: "19253212508" ;tag=as6cefe95d To: ;tag=401817453 Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.61.0.80 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339102@50.0.205.141:1060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK00f0577e;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as6cefe95d To: ;tag=401817453 Contact: Call-ID: 56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '56417a443820d24c045aa84d589d9525@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK09313fc5;rport=5060 From: "19253212508" ;tag=as7d7e2d50 To: ;tag=1774851890 Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.61.0.80 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339107@50.0.205.141:1061 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK09313fc5;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as7d7e2d50 To: ;tag=1774851890 Contact: Call-ID: 6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '6894c40c4d0b72e47298ad7c34219746@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339105@50.0.205.141:1028 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK43f36368;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Contact: Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> ACK sip:4159224339@yyy.yyy.yyy.174:5060;transport=udp SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKbf8e.f3241ef4.2 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK1sansay50084464rdb14528-200 Route: To: ;tag=as6d9ae0b0 From: ;tag=sansay50084464rdb14528 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 1 ACK Max-Forwards: 69 Content-Length: 0 X-Enswitch-RURI: sip:4159224339@yyy.yyy.yyy.166:5060 X-Enswitch-Source: xxx.xxx.xxx.30:5060 X-Enswitch-External: yes <-------------> --- (14 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK2dbf2d95;rport=5060 From: "19253212508" ;tag=as62dfaba6 To: ;tag=306966694 Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.61.0.80 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:4339104@50.0.205.141:1059 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK2dbf2d95;rport Route: Max-Forwards: 70 From: "19253212508" ;tag=as62dfaba6 To: ;tag=306966694 Contact: Call-ID: 26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- Really destroying SIP dialog '26b7afdb3f7015ec647538aa388f1d59@yyy.yyy.yyy.174:5060' Method: INVITE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> INVITE sip:4159224339@yyy.yyy.yyy.174:5060;transport=udp SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK8f8e.1fb0c87.0 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK2sansay50084464rdb14528 Route: To: ;tag=as6d9ae0b0 From: ;tag=sansay50084464rdb14528 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 2 INVITE Contact: Supported: timer Session-Expires: 1800;refresher=uac Min-SE: 1800 Max-Forwards: 68 Content-Type: application/sdp Content-Length: 251 X-Enswitch-RURI: sip:4159224339@yyy.yyy.yyy.166:5060 X-Enswitch-Source: xxx.xxx.xxx.30:5060 X-Enswitch-External: yes v=0 o=Sansay-VSXi 188 2 IN IP4 xxx.xxx.xxx.30 s=Session Controller c=IN IP4 208.93.47.132 t=0 0 m=audio 9438 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=direction: passive a=sendrecv a=maxptime:20 <-------------> --- (19 headers 12 lines) --- Sending to yyy.yyy.yyy.166:5060 (NAT) Found RTP audio format 0 Found RTP audio format 101 Found audio description format PCMU for ID 0 Found audio description format telephone-event for ID 101 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x4 (ulaw)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x4 (ulaw) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 208.93.47.132:9438 Peer doesn't provide video <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK8f8e.1fb0c87.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK2sansay50084464rdb14528 Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 2 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Length: 0 <------------> Audio is at 10088 Adding codec 0x4 (ulaw) to SDP Adding non-codec 0x1 (telephone-event) to SDP <--- Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK8f8e.1fb0c87.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK2sansay50084464rdb14528 Record-Route: From: ;tag=sansay50084464rdb14528 To: ;tag=as6d9ae0b0 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 2 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Session-Expires: 1800;refresher=uac Contact: Content-Type: application/sdp Content-Length: 238 v=0 o=root 634336327 634336328 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 t=0 0 m=audio 10088 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv <------------> <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> ACK sip:4159224339@yyy.yyy.yyy.174:5060;transport=udp SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK8f8e.1fb0c87.2 Via: SIP/2.0/UDP xxx.xxx.xxx.30:5060;branch=z9hG4bK2sansay50084464rdb14528-200 Route: To: ;tag=as6d9ae0b0 From: ;tag=sansay50084464rdb14528 Call-ID: 660692327-0-445158760@xxx.xxx.xxx.226 CSeq: 2 ACK Max-Forwards: 69 Content-Length: 0 X-Enswitch-RURI: sip:4159224339@yyy.yyy.yyy.166:5060 X-Enswitch-Source: xxx.xxx.xxx.30:5060 X-Enswitch-External: yes <-------------> --- (14 headers 0 lines) --- -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:53715 ---> OPTIONS sip:yyy.yyy.yyy.174:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.166:57434;branch=z9hG4bK.37b8224e;rport;alias From: sip:sipsak@yyy.yyy.yyy.166:57434;tag=7a7f3763 To: sip:yyy.yyy.yyy.174:5060 Call-ID: 2055157603@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Contact: sip:sipsak@yyy.yyy.yyy.166:57434 Content-Length: 0 Max-Forwards: 70 User-Agent: sipsak 0.9.6 Accept: text/plain <-------------> --- (11 headers 0 lines) --- Looking for s in from-external (domain yyy.yyy.yyy.174) <--- Transmitting (NAT) to yyy.yyy.yyy.166:53715 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166:57434;branch=z9hG4bK.37b8224e;alias;received=yyy.yyy.yyy.166;rport=53715 From: sip:sipsak@yyy.yyy.yyy.166:57434;tag=7a7f3763 To: sip:yyy.yyy.yyy.174:5060;tag=as27060fac Call-ID: 2055157603@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 <------------> Scheduling destruction of SIP dialog '2055157603@yyy.yyy.yyy.166' in 32000 ms (Method: OPTIONS) <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> INVITE sip:1234202@yyy.yyy.yyy.174:5060;transport=udp SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc632.ceb61902.0 Via: SIP/2.0/UDP 192.168.15.22:5062;rport=1047;received=70.36.252.186;branch=z9hG4bK1860654984 From: "1234201" ;tag=1410715518 To: Call-ID: 1644587232@192.168.15.22 CSeq: 2 INVITE Contact: Proxy-Authorization: Digest username="1234201", realm="yyy.yyy.yyy.166", nonce="4f5571570000e9aeb9628e6662055b9fcce1b357dbf33d79", uri="sip:1234202@yyy.yyy.yyy.166", response="a1dbf77881e86c774d0fdd85a2859289", algorithm=MD5 Content-Type: application/sdp Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE Max-Forwards: 69 User-Agent: Yealink SIP-T26P 6.60.0.120 Supported: replaces Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 356 X-Enswitch-RURI: sip:1234202@yyy.yyy.yyy.166 X-Enswitch-Source: 70.36.252.186:1047 v=0 o=- 20264 20264 IN IP4 192.168.15.22 s=SDP data c=IN IP4 70.36.252.186 t=0 0 m=audio 11800 RTP/AVP 0 8 18 9 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:9 G722/8000 a=fmtp:101 0-15 a=rtpmap:101 telephone-event/8000 a=ptime:20 a=sendrecv a=direction:active a=oldmediaip:192.168.15.22 <-------------> --- (19 headers 17 lines) --- == Using UDPTL CoS mark 5 Sending to yyy.yyy.yyy.166:5060 (NAT) Using INVITE request as basis request - 1644587232@192.168.15.22 Found peer 'product-local' for '1234201' from yyy.yyy.yyy.166:5060 == Using SIP RTP CoS mark 5 Found RTP audio format 0 Found RTP audio format 8 Found RTP audio format 18 Found RTP audio format 9 Found RTP audio format 101 Found audio description format PCMU for ID 0 Found audio description format PCMA for ID 8 Found audio description format G729 for ID 18 Found audio description format G722 for ID 9 Found audio description format telephone-event for ID 101 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x110c (ulaw|alaw|g729|g722)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x1104 (ulaw|g729|g722) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 70.36.252.186:11800 Peer doesn't provide video Looking for 1234202 in from-internal (domain yyy.yyy.yyy.174) list_route: hop: <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc632.ceb61902.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP 192.168.15.22:5062;rport=1047;received=70.36.252.186;branch=z9hG4bK1860654984 Record-Route: From: "1234201" ;tag=1410715518 To: Call-ID: 1644587232@192.168.15.22 CSeq: 2 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Content-Length: 0 <------------> -- Executing [1234202@from-internal:1] AGI("SIP/product-local-000051b9", "agi://127.0.0.1/product?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: product?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/product?stype=internal AGI Tx >> agi_channel: SIP/product-local-000051b9 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999609.70086 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 1234201 AGI Tx >> agi_calleridname: 1234201 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 1234202 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 1234202 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1097026448 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:49 2012 (1330999609)" 9 > agi://127.0.0.1/product?stype=internal: AGI starting at Mon Mar 5 18:06:49 2012 (1330999609) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-CALLID "1330999609.70086" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:49.987 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:49.988 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-Source) AGI Tx >> 200 result=1 (70.36.252.186:1047) AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(X-Enswitch-External) AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-TRANSFER-CUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIP_HEADER(Proxy-Authorization) AGI Tx >> 200 result=1 (Digest username="1234201", realm="yyy.yyy.yyy.166", nonce="4f5571570000e9aeb9628e6662055b9fcce1b357dbf33d79", uri="sip:1234202@yyy.yyy.yyy.166", response="a1dbf77881e86c774d0fdd85a2859289", algorithm=MD5) AGI Rx << SET VARIABLE __SIPADDHEADER01 "Alert-Info: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type '', number '1234202', old '', forward 1 for channel SIP/product-local-000051b9" 5 > agi://127.0.0.1/product?stype=internal: Resolving type '', number '1234202', old '', forward 1 for channel SIP/product-local-000051b9 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Starting recording group '1' expires '1346551610' file '/var/lib/product/recordings/es1-s2-1/970/086/record_133099960970086_12599'" 9 > agi://127.0.0.1/product?stype=internal: Starting recording group '1' expires '1346551610' file '/var/lib/product/recordings/es1-s2-1/970/086/record_133099960970086_12599' AGI Tx >> 200 result=1 AGI Rx << EXEC Monitor "gsm,/var/lib/product/recordings/es1-s2-1/970/086/record_133099960970086_12599" -- AGI Script Executing Application: (Monitor) Options: (gsm,/var/lib/product/recordings/es1-s2-1/970/086/record_133099960970086_12599) AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Writing entry to active table for 1330999609.70086, phone:1234201 - phone:1234202." 9 > agi://127.0.0.1/product?stype=internal: Writing entry to active table for 1330999609.70086, phone:1234201 - phone:1234202. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE SIP_HEADER(Call-ID) AGI Tx >> 200 result=1 (1644587232@192.168.15.22) AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 (1234201) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:50.081 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "2" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "1234202" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "1234201" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "2" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ort" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "1234202" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/1234202@product-phone/n,30,o" -- AGI Script Executing Application: (Dial) Options: (Local/1234202@product-phone/n,30,o) -- Called Local/1234202@product-phone/n -- Executing [1234202@product-phone:1] GotoIf("Local/1234202@product-phone-a75a;2", "0?3") in new stack -- Executing [1234202@product-phone:2] SetMusicOnHold("Local/1234202@product-phone-a75a;2", "default") in new stack -- Executing [1234202@product-phone:3] Dial("Local/1234202@product-phone-a75a;2", "SIP/1234202@yyy.yyy.yyy.166:5060,3600,ort") in new stack == Using UDPTL CoS mark 5 == Using SIP RTP CoS mark 5 Audio is at 12978 Video is at yyy.yyy.yyy.174:15796 Adding codec 0x1000 (g722) to SDP Adding codec 0x4 (ulaw) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:1234202@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK6fdd51fc;rport Max-Forwards: 70 From: "1234201" ;tag=as73b10aed To: Contact: Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Alert-Info: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1259087161 1259087161 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 12978 RTP/AVP 9 0 18 101 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 15796 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/1234202@yyy.yyy.yyy.166:5060 -- Local/1234202@product-phone-a75a;1 is ringing <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc632.ceb61902.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP 192.168.15.22:5062;rport=1047;received=70.36.252.186;branch=z9hG4bK1860654984 Record-Route: From: "1234201" ;tag=1410715518 To: ;tag=as3a179e8c Call-ID: 1644587232@192.168.15.22 CSeq: 2 INVITE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Content-Length: 0 <------------> <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK6fdd51fc;rport=5060 From: "1234201" ;tag=as73b10aed To: Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3915 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:1234202@yyy.yyy.yyy.166:5060 out_uri=sip:1234202@192.168.15.21:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK6fdd51fc;rport=5060 Record-Route: From: "1234201" ;tag=as73b10aed To: ;tag=1278327432 Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.120 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051ba is ringing -- Local/1234202@product-phone-a75a;1 is ringing Really destroying SIP dialog '678124883@yyy.yyy.yyy.166' Method: OPTIONS <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK6fdd51fc;rport=5060 Record-Route: From: "1234201" ;tag=as73b10aed To: ;tag=1278327432 Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Content-Type: application/sdp Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 319 v=0 o=- 20013 20013 IN IP4 192.168.15.21 s=SDP data c=IN IP4 70.36.252.186 t=0 0 m=audio 11784 RTP/AVP 9 101 a=rtpmap:9 G722/8000 a=sendrecv a=ptime:20 a=fmtp:101 0-15 a=rtpmap:101 telephone-event/8000 m=video 0 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv a=direction:active a=oldmediaip:192.168.15.21 <-------------> --- (12 headers 16 lines) --- Found RTP audio format 9 Found RTP audio format 101 Found audio description format G722 for ID 9 Found audio description format telephone-event for ID 101 [Mar 5 18:06:53] WARNING[26047]: chan_sip.c:8942 process_sdp: Unsupported SDP media type in offer: video 0 RTP/AVP 99 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x1000 (g722)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x1000 (g722) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 70.36.252.186:11784 Peer doesn't provide video set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:1234202@70.36.252.186:1164 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK1e184f72;rport Route: Max-Forwards: 70 From: "1234201" ;tag=as73b10aed To: ;tag=1278327432 Contact: Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- -- SIP/yyy.yyy.yyy.166:5060-000051ba answered Local/1234202@product-phone-a75a;2 -- Local/1234202@product-phone-a75a;1 stopped sounds -- Local/1234202@product-phone-a75a;1 answered SIP/product-local-000051b9 Audio is at 14756 Adding codec 0x1000 (g722) to SDP Adding codec 0x4 (ulaw) to SDP Adding codec 0x100 (g729) to SDP Adding non-codec 0x1 (telephone-event) to SDP <--- Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc632.ceb61902.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP 192.168.15.22:5062;rport=1047;received=70.36.252.186;branch=z9hG4bK1860654984 Record-Route: From: "1234201" ;tag=1410715518 To: ;tag=as3a179e8c Call-ID: 1644587232@192.168.15.22 CSeq: 2 INVITE Server: Enswitch llow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Content-Type: application/sdp Content-Length: 311 v=0 o=root 1762607195 1762607195 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 t=0 0 m=audio 14756 RTP/AVP 9 0 18 101 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv <------------> <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> ACK sip:1234202@yyy.yyy.yyy.174:5060 SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bKc632.ceb61902.2 Via: SIP/2.0/UDP 192.168.15.22:5062;rport=1047;received=70.36.252.186;branch=z9hG4bK972700626 Route: From: "1234201" ;tag=1410715518 To: ;tag=as3a179e8c Call-ID: 1644587232@192.168.15.22 CSeq: 2 ACK Contact: Proxy-Authorization: Digest username="1234201", realm="yyy.yyy.yyy.166", nonce="4f5571570000e9aeb9628e6662055b9fcce1b357dbf33d79", uri="sip:1234202@yyy.yyy.yyy.166", response="a1dbf77881e86c774d0fdd85a2859289", algorithm=MD5 Max-Forwards: 69 User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 0 X-Enswitch-RURI: sip:1234202@yyy.yyy.yyy.174:5060 X-Enswitch-Source: 70.36.252.186:1047 <-------------> --- (16 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- -- Started music on hold, class 'default', on Local/1234202@product-phone-a75a;2 -- Playing 'pbx-transfer.g722' (language 'en') <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- -- Executing [1234513@from-internal:1] AGI("Local/1234513@from-internal-06f4;2", "agi://127.0.0.1/product?stype=internal") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: product?stype=internal AGI Tx >> agi_request: agi://127.0.0.1/product?stype=internal AGI Tx >> agi_channel: Local/1234513@from-internal-06f4;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999618.70091 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 1234201 AGI Tx >> agi_calleridname: 1234201 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: 1234513 AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1100381072 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:06:58 2012 (1330999618)" 9 > agi://127.0.0.1/product?stype=internal: AGI starting at Mon Mar 5 18:06:58 2012 (1330999618) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999609.70086) AGI Rx << GET VARIABLE PRODUCT-SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERTED AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-DIVERSION AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __PRODUCT-MUSIC "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(musicclass) "default" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __TRANSFER_CONTEXT "from-internal" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:58.914 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CUTOFF AGI Tx >> 200 result=1 (86400) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:58.915 PST. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-SCUSTOMER AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-PRESENTATION AGI Tx >> 200 result=1 (1) AGI Rx << SET VARIABLE DUMMY "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DUMMY AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE PRODUCT-TRANSFER-PHONE AGI Tx >> 200 result=1 (1234202) AGI Rx << VERBOSE "Transfer by telephone 1234202" 9 > agi://127.0.0.1/product?stype=internal: Transfer by telephone 1234202 AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE PRODUCT-TRANSFER-PHONE "" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __SIPADDHEADER01 "Alert-Info: " AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Resolving type '', number '1234513', old '', forward 1 for channel Local/1234513@from-internal-06f4;2" 5 > agi://127.0.0.1/product?stype=internal: Resolving type '', number '1234513', old '', forward 1 for channel Local/1234513@from-internal-06f4;2 AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Starting recording group '1' expires '1346551618' file '/var/lib/product/recordings/es1-s2-1/870/091/record_133099961870091_14514'" 9 > agi://127.0.0.1/product?stype=internal: Starting recording group '1' expires '1346551618' file '/var/lib/product/recordings/es1-s2-1/870/091/record_133099961870091_14514' AGI Tx >> 200 result=1 AGI Rx << EXEC Monitor "gsm,/var/lib/product/recordings/es1-s2-1/870/091/record_133099961870091_14514" -- AGI Script Executing Application: (Monitor) Options: (gsm,/var/lib/product/recordings/es1-s2-1/870/091/record_133099961870091_14514) AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Writing entry to active table for 1330999618.70091, phone:1234202 - phone:1234513." 9 > agi://127.0.0.1/product?stype=internal: Writing entry to active table for 1330999618.70091, phone:1234202 - phone:1234513. AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE CALLERID(name) AGI Tx >> 200 result=1 (1234201) AGI Rx << SET VARIABLE TIMEOUT(absolute) "86400" Channel will hangup at 2012-03-06 18:06:59.013 PST. AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DCUSTOMER "2" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DTYPE "phone" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-DNUMBER "1234513" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLER "no" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __LIMIT_PLAYAUDIO_CALLEE "yes" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CALLERID(number) "1234201" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-CUSTOMER "2" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PRESENTATION "1" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-CUTOFF "86400" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-DOMAIN "yyy.yyy.yyy.166:5060" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-PHONE-OPTS "ort" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __PRODUCT-TRANSFER-PHONE "1234513" AGI Tx >> 200 result=1 AGI Rx << EXEC Dial "Local/1234513@product-phone/n,25,o" -- AGI Script Executing Application: (Dial) Options: (Local/1234513@product-phone/n,25,o) -- Called Local/1234513@product-phone/n -- Executing [1234513@product-phone:1] GotoIf("Local/1234513@product-phone-f73c;2", "0?3") in new stack -- Executing [1234513@product-phone:2] SetMusicOnHold("Local/1234513@product-phone-f73c;2", "default") in new stack -- Executing [1234513@product-phone:3] Dial("Local/1234513@product-phone-f73c;2", "SIP/1234513@yyy.yyy.yyy.166:5060,3600,ort") in new stack == Using UDPTL CoS mark 5 == Using SIP RTP CoS mark 5 Audio is at 17446 Video is at yyy.yyy.yyy.174:11468 Adding codec 0x1000 (g722) to SDP Adding codec 0x4 (ulaw) to SDP Adding codec 0x100 (g729) to SDP Adding video codec 0x200000 (h264) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: INVITE sip:1234513@yyy.yyy.yyy.166:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK6c5947df;rport Max-Forwards: 70 From: "1234201" ;tag=as6533c68f To: Contact: Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Enswitch Date: Tue, 06 Mar 2012 02:06:59 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Alert-Info: Content-Type: application/sdp Content-Length: 383 v=0 o=root 1817191479 1817191479 IN IP4 yyy.yyy.yyy.174 s=Asterisk PBX 1.8.9.2 c=IN IP4 yyy.yyy.yyy.174 b=CT:384 t=0 0 m=audio 17446 RTP/AVP 9 0 18 101 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv m=video 11468 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv --- -- Called SIP/1234513@yyy.yyy.yyy.166:5060 -- Local/1234513@product-phone-f73c;1 is ringing -- Local/1234513@from-internal-06f4;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 100 Giving a try Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK6c5947df;rport=5060 From: "1234201" ;tag=as6533c68f To: Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Server: Enswitch SIP proxy Content-Length: 0 Warning: 392 yyy.yyy.yyy.166:5060 "Noisy feedback tells: pid=3912 req_src_ip=yyy.yyy.yyy.174 req_src_port=5060 in_uri=sip:1234513@yyy.yyy.yyy.166:5060 out_uri=sip:1234513@192.168.15.30:5062 via_cnt==1" <-------------> --- (9 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK6c5947df;rport=5060 Record-Route: From: "1234201" ;tag=as6533c68f To: ;tag=1101806535 Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.120 Allow-Events: talk,hold,conference,refer,check-sync Content-Length: 0 <-------------> --- (12 headers 0 lines) --- list_route: hop: -- SIP/yyy.yyy.yyy.166:5060-000051bb is ringing -- Local/1234513@product-phone-f73c;1 is ringing <--- SIP read from UDP:yyy.yyy.yyy.166:47982 ---> OPTIONS sip:yyy.yyy.yyy.174:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.166:51344;branch=z9hG4bK.0cb87184;rport;alias From: sip:sipsak@yyy.yyy.yyy.166:51344;tag=5e1e65b0 To: sip:yyy.yyy.yyy.174:5060 Call-ID: 1579050416@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Contact: sip:sipsak@yyy.yyy.yyy.166:51344 Content-Length: 0 Max-Forwards: 70 User-Agent: sipsak 0.9.6 Accept: text/plain <-------------> --- (11 headers 0 lines) --- Looking for s in from-external (domain yyy.yyy.yyy.174) <--- Transmitting (NAT) to yyy.yyy.yyy.166:47982 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166:51344;branch=z9hG4bK.0cb87184;alias;received=yyy.yyy.yyy.166;rport=47982 From: sip:sipsak@yyy.yyy.yyy.166:51344;tag=5e1e65b0 To: sip:yyy.yyy.yyy.174:5060;tag=as296456c5 Call-ID: 1579050416@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 <------------> Scheduling destruction of SIP dialog '1579050416@yyy.yyy.yyy.166' in 32000 ms (Method: OPTIONS) Really destroying SIP dialog 'ee333232805a9c5a' Method: BYE <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK6c5947df;rport=5060 Record-Route: From: "1234201" ;tag=as6533c68f To: ;tag=1101806535 Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE Contact: Content-Type: application/sdp Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 319 v=0 o=- 20017 20017 IN IP4 192.168.15.30 s=SDP data c=IN IP4 70.36.252.186 t=0 0 m=audio 11796 RTP/AVP 9 101 a=rtpmap:9 G722/8000 a=sendrecv a=ptime:20 a=fmtp:101 0-15 a=rtpmap:101 telephone-event/8000 m=video 0 RTP/AVP 99 a=rtpmap:99 H264/90000 a=sendrecv a=direction:active a=oldmediaip:192.168.15.30 <-------------> --- (12 headers 16 lines) --- Found RTP audio format 9 Found RTP audio format 101 Found audio description format G722 for ID 9 Found audio description format telephone-event for ID 101 [Mar 5 18:07:00] WARNING[26047]: chan_sip.c:8942 process_sdp: Unsupported SDP media type in offer: video 0 RTP/AVP 99 Capabilities: us - 0x201104 (ulaw|g729|g722|h264), peer - audio=0x1000 (g722)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x1000 (g722) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 70.36.252.186:11796 Peer doesn't provide video set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Transmitting (NAT) to yyy.yyy.yyy.166:5060: ACK sip:1234513@70.36.252.186:1162 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK74098bd1;rport Route: Max-Forwards: 70 From: "1234201" ;tag=as6533c68f To: ;tag=1101806535 Contact: Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 102 ACK User-Agent: Enswitch Content-Length: 0 --- -- SIP/yyy.yyy.yyy.166:5060-000051bb answered Local/1234513@product-phone-f73c;2 -- Local/1234513@product-phone-f73c;1 stopped sounds -- Local/1234513@product-phone-f73c;1 answered Local/1234513@from-internal-06f4;2 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- Really destroying SIP dialog '569789099@yyy.yyy.yyy.166' Method: OPTIONS <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> BYE sip:1234201@yyy.yyy.yyy.174:5060 SIP/2.0 Record-Route: Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK2fe4.0f022981.0 Via: SIP/2.0/UDP 192.168.15.30:5062;rport=1162;received=70.36.252.186;branch=z9hG4bK812654745 From: ;tag=1101806535 To: "1234201" ;tag=as6533c68f Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 103 BYE Contact: Max-Forwards: 69 User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 0 X-Enswitch-RURI: sip:1234201@yyy.yyy.yyy.174:5060 X-Enswitch-Source: 70.36.252.186:1162 <-------------> --- (14 headers 0 lines) --- Sending to yyy.yyy.yyy.166:5060 (NAT) Scheduling destruction of SIP dialog '7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060' in 32000 ms (Method: BYE) <--- Transmitting (NAT) to yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166;branch=z9hG4bK2fe4.0f022981.0;received=yyy.yyy.yyy.166;rport=5060 Via: SIP/2.0/UDP 192.168.15.30:5062;rport=1162;received=70.36.252.186;branch=z9hG4bK812654745 Record-Route: From: ;tag=1101806535 To: "1234201" ;tag=as6533c68f Call-ID: 7471a47f682b826c5d02cb69120a26d6@yyy.yyy.yyy.174:5060 CSeq: 103 BYE Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Content-Length: 0 <------------> == Spawn extension (product-phone, 1234513, 3) exited non-zero on 'Local/1234513@product-phone-f73c;2' -- Executing [h@from-internal:1] AGI("Local/1234513@from-internal-06f4;2", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: Local/1234513@from-internal-06f4;2 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1330999618.70091 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 1234201 AGI Tx >> agi_calleridname: 1234201 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1100381072 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:07:04 2012 (1330999624)" 9 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:07:04 2012 (1330999624) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999609.70086) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 (4) AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (ANSWER) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP AGI Tx >> 200 result=-1 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/product?stype=internal completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:07:05] ERROR[14569]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (from-internal, 1234513, 1) exited non-zero on 'Local/1234513@from-internal-06f4;2' -- Executing [h@from-external:1] AGI("SIP/yyy.yyy.yyy.166:5060-000051ba", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/yyy.yyy.yyy.166:5060-000051ba AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999610.70089 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 1234201 AGI Tx >> agi_calleridname: 1234201 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-external AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1131215760 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:07:05 2012 (1330999625)" 9 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:07:05 2012 (1330999625) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999609.70086) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP [Mar 5 18:07:06] WARNING[14542]: file.c:766 ast_readaudio_callback: Failed to write frame -- Playing 'beep.g722' (language 'en') [Mar 5 18:07:06] WARNING[14542]: features.c:2587 builtin_atxfer: Failed to play transfer sound! -- Stopped music on hold on Local/1234202@product-phone-a75a;2 Scheduling destruction of SIP dialog '4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: BYE sip:1234202@70.36.252.186:1164 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK4d251a03;rport Route: Max-Forwards: 70 From: "1234201" ;tag=as73b10aed To: ;tag=1278327432 Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 103 BYE User-Agent: Enswitch X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 --- == Spawn extension (product-phone, 1234202, 3) exited non-zero on 'Local/1234202@product-phone-a75a;2' -- Executing [h@from-internal:1] AGI("SIP/product-local-000051b9", "agi://127.0.0.1/end") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: end AGI Tx >> agi_request: agi://127.0.0.1/end AGI Tx >> agi_channel: SIP/product-local-000051b9 AGI Tx >> agi_language: en AGI Tx >> agi_type: SIP AGI Tx >> agi_uniqueid: 1330999609.70086 AGI Tx >> agi_version: 1.8.9.2 AGI Tx >> agi_callerid: 1234201 AGI Tx >> agi_calleridname: 1234201 AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: 1234202 AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: from-internal AGI Tx >> agi_extension: h AGI Tx >> agi_priority: 1 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 1097026448 AGI Tx >> AGI Rx << VERBOSE "AGI starting at Mon Mar 5 18:07:06 2012 (1330999626)" 9 > agi://127.0.0.1/end: AGI starting at Mon Mar 5 18:07:06 2012 (1330999626) AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE CHANNEL(language) "en" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE PRODUCT-CALLID AGI Tx >> 200 result=1 (1330999609.70086) AGI Rx << GET VARIABLE ANSWEREDTIME AGI Tx >> 200 result=1 (13) AGI Rx << GET VARIABLE DIALSTATUS AGI Tx >> 200 result=1 (ANSWER) AGI Rx << GET VARIABLE PRODUCT-HANGUP-URL AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-ADD-CARD AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE PRODUCT-FAX-FILE AGI Tx >> 200 result=0 <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK4d251a03;rport=5060 From: "1234201" ;tag=as73b10aed To: ;tag=1278327432 Call-ID: 4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060 CSeq: 103 BYE User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- Really destroying SIP dialog '4ce4a9c910c3407f245305f6465afb20@yyy.yyy.yyy.174:5060' Method: INVITE -- AGI Script agi://127.0.0.1/end completed, returning 0 AGI Tx >> HANGUP AGI Tx >> 200 result=-1 AGI Tx >> HANGUP -- AGI Script agi://127.0.0.1/product?stype=internal completed, returning 4 AGI Tx >> HANGUP [Mar 5 18:07:07] ERROR[14540]: utils.c:1164 ast_carefulwrite: write() returned error: Broken pipe == Spawn extension (from-internal, 1234202, 1) exited non-zero on 'SIP/product-local-000051b9' Scheduling destruction of SIP dialog '1644587232@192.168.15.22' in 32000 ms (Method: ACK) set_destination: Parsing for address/port to send to set_destination: set destination to yyy.yyy.yyy.166:5060 Reliably Transmitting (NAT) to yyy.yyy.yyy.166:5060: BYE sip:1234201@70.36.252.186:1047 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;branch=z9hG4bK3fab8649;rport Route: Max-Forwards: 70 From: ;tag=as3a179e8c To: "1234201" ;tag=1410715518 Call-ID: 1644587232@192.168.15.22 CSeq: 102 BYE User-Agent: Enswitch X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 -- <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK3fab8649;rport=5060 From: ;tag=as3a179e8c To: "1234201" ;tag=1410715518 Call-ID: 1644587232@192.168.15.22 CSeq: 102 BYE User-Agent: Yealink SIP-T26P 6.60.0.120 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- SIP Response message for INCOMING dialog BYE arrived Really destroying SIP dialog '1644587232@192.168.15.22' Method: ACK <--- SIP read from UDP:yyy.yyy.yyy.166:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP yyy.yyy.yyy.174:5060;received=yyy.yyy.yyy.174;branch=z9hG4bK43f36368;rport=5060 From: "19253212508" ;tag=as4a1cacf8 To: ;tag=1182706049 Call-ID: 6266107f24b4122b0b74f48106331945@yyy.yyy.yyy.174:5060 CSeq: 102 INVITE User-Agent: Yealink SIP-T26P 6.60.0.140 Content-Length: 0 <-------------> --- (8 headers 0 lines) --- <--- SIP read from UDP:yyy.yyy.yyy.166:43672 ---> OPTIONS sip:yyy.yyy.yyy.174:5060 SIP/2.0 Via: SIP/2.0/UDP yyy.yyy.yyy.166:47002;branch=z9hG4bK.7165c295;rport;alias From: sip:sipsak@yyy.yyy.yyy.166:47002;tag=649874ef To: sip:yyy.yyy.yyy.174:5060 Call-ID: 1687713007@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Contact: sip:sipsak@yyy.yyy.yyy.166:47002 Content-Length: 0 Max-Forwards: 70 User-Agent: sipsak 0.9.6 Accept: text/plain <-------------> --- (11 headers 0 lines) --- Looking for s in from-external (domain yyy.yyy.yyy.174) <--- Transmitting (NAT) to yyy.yyy.yyy.166:43672 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP yyy.yyy.yyy.166:47002;branch=z9hG4bK.7165c295;alias;received=yyy.yyy.yyy.166;rport=43672 From: sip:sipsak@yyy.yyy.yyy.166:47002;tag=649874ef To: sip:yyy.yyy.yyy.174:5060;tag=as35ef671c Call-ID: 1687713007@yyy.yyy.yyy.166 CSeq: 1 OPTIONS Server: Enswitch Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 <------------> Scheduling destruction of SIP dialog '1687713007@yyy.yyy.yyy.166' in 32000 ms (Method: OPTIONS) Really destroying SIP dialog '1496325411@yyy.yyy.yyy.166' Method: OPTIONS es1-s2-1*CLI> Disconnected from Asterisk server [root@es1-s2-1 ~]#