Date: Fri, 22 Feb 2008 01:56:22 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Retransmitting #4 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0f707300;rport From: "Unknown" ;tag=as4c2cdf21 To: Contact: Call-ID: 0dead49b6b4237590b48424c01afd6a4@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:22 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Destroying call '0dead49b6b4237590b48424c01afd6a4@123.456.789.10' Destroying call '07ef11cc36041826172d27770e5b4c70@123.456.789.10' Destroying call '4487bc31301964ea2b7051c2276a22ea@123.456.789.10' -- Timeout on SIP/23456789-b7009248, going to 't' -- Executing Goto("SIP/23456789-b7009248", "loop|1") in new stack -- Goto (ivr-4,loop,1) -- Executing Set("SIP/23456789-b7009248", "LOOPCOUNT=2") in new stack -- Executing GotoIf("SIP/23456789-b7009248", "0?hang|1") in new stack -- Executing Goto("SIP/23456789-b7009248", "ivr-4|s|begin") in new stack -- Goto (ivr-4,s,8) -- Executing Set("SIP/23456789-b7009248", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3 -- Executing Set("SIP/23456789-b7009248", "TIMEOUT(response)=10") in new stack -- Response timeout set to 10 -- Executing BackGround("SIP/23456789-b7009248", "custom/ivr-sip-provider-2") in new stack -- Playing 'custom/ivr-sip-provider-2' (language 'en') --- Scheduling destruction of call '1887313050-1315420565@192.168.0.103' in 15000 ms 12 headers, 0 lines Reliably Transmitting (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport From: "Unknown" ;tag=as7bc6b1e8 To: Contact: Call-ID: 3de239f44c3d8664127d63c15b30398c@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Scheduling destruction of call '1887313050-1315420565@192.168.0.103' in 15000 ms Retransmitting #1 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport From: "Unknown" ;tag=as7bc6b1e8 To: Contact: Call-ID: 3de239f44c3d8664127d63c15b30398c@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Retransmitting #2 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport From: "Unknown" ;tag=as7bc6b1e8 To: Contact: Call-ID: 3de239f44c3d8664127d63c15b30398c@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- -- Executing WaitExten("SIP/23456789-0821de80", "|") in new stack Retransmitting #3 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport From: "Unknown" ;tag=as7bc6b1e8 To: Contact: Call-ID: 3de239f44c3d8664127d63c15b30398c@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Retransmitting #4 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport From: "Unknown" ;tag=as7bc6b1e8 To: Contact: Call-ID: 3de239f44c3d8664127d63c15b30398c@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:36 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Destroying call '3de239f44c3d8664127d63c15b30398c@123.456.789.10' -- Executing WaitExten("SIP/23456789-b7009248", "|") in new stack Reliably Transmitting (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport From: "Unknown" ;tag=as6740d2f8 To: Contact: Call-ID: 6ccaccaf282845f572e4ba1442a528e0@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- == Manager 'admin' logged off from 127.0.0.1 Retransmitting #1 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport From: "Unknown" ;tag=as6740d2f8 To: Contact: Call-ID: 6ccaccaf282845f572e4ba1442a528e0@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- -- Timeout on SIP/23456789-b7009248, going to 't' -- Executing Goto("SIP/23456789-b7009248", "loop|1") in new stack -- Goto (ivr-4,loop,1) -- Executing Set("SIP/23456789-b7009248", "LOOPCOUNT=3") in new stack -- Executing GotoIf("SIP/23456789-b7009248", "1?hang|1") in new stack -- Goto (ivr-4,hang,1) -- Executing Playback("SIP/23456789-b7009248", "vm-goodbye") in new stack -- Playing 'vm-goodbye' (language 'en') Destroying call '1887313050-1315420565@192.168.0.103' Retransmitting #2 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport From: "Unknown" ;tag=as6740d2f8 To: Contact: Call-ID: 6ccaccaf282845f572e4ba1442a528e0@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- -- Executing Hangup("SIP/23456789-b7009248", "") in new stack == Spawn extension (ivr-4, hang, 2) exited non-zero on 'SIP/23456789-b7009248' -- Executing Hangup("SIP/23456789-b7009248", "") in new stack == Spawn extension (ivr-4, h, 1) exited non-zero on 'SIP/23456789-b7009248' Scheduling destruction of call '7633159@111.222.31.249' in 32000 ms set_destination: Parsing for address/port to send to set_destination: set destination to 111.222.31.243, port 5060 Reliably Transmitting (no NAT) to 111.222.31.243:5060: BYE sip:98765432@111.222.31.249:6889 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK678093fc;rport Route: From: ;tag=as507ee9af To: ;tag=950731239 Call-ID: 7633159@111.222.31.249 CSeq: 102 BYE User-Agent: Asterisk PBX Max-Forwards: 70 Content-Length: 0 --- sipc*CLI> <-- SIP read from 111.222.31.243:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK678093fc;rport=5060 From: ;tag=as507ee9af To: ;tag=950731239 Call-ID: 7633159@111.222.31.249 CSeq: 102 BYE User-Agent: sip-gw V 3.1.2 070924 Content-Length: 0 --- (8 headers 0 lines) --- Destroying call '7633159@111.222.31.249' Retransmitting #3 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport From: "Unknown" ;tag=as6740d2f8 To: Contact: Call-ID: 6ccaccaf282845f572e4ba1442a528e0@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- -- Timeout on SIP/23456789-0821de80, going to 't' -- Executing DBdel("SIP/23456789-0821de80", "") in new stack -- Executing Set("SIP/23456789-0821de80", "__NODEST=") in new stack -- Executing Goto("SIP/23456789-0821de80", "from-did-direct|300|1") in new stack -- Goto (from-did-direct,300,1) -- Executing Macro("SIP/23456789-0821de80", "exten-vm|novm|300") in new stack -- Executing Macro("SIP/23456789-0821de80", "user-callerid") in new stack -- Executing NoOp("SIP/23456789-0821de80", "user-callerid: 98765432 98765432") in new stack -- Executing Set("SIP/23456789-0821de80", "AMPUSER=98765432") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "0?report") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "0?start") in new stack -- Executing Set("SIP/23456789-0821de80", "REALCALLERIDNUM=98765432") in new stack -- Executing NoOp("SIP/23456789-0821de80", "REALCALLERIDNUM is 98765432") in new stack -- Executing Set("SIP/23456789-0821de80", "AMPUSER=") in new stack -- Executing Set("SIP/23456789-0821de80", "AMPUSERCIDNAME=") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "1?report") in new stack -- Goto (macro-user-callerid,s,13) -- Executing NoOp("SIP/23456789-0821de80", "TTL: ARG1: novm") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "0?continue") in new stack -- Executing Set("SIP/23456789-0821de80", "__TTL=64") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "1?continue") in new stack -- Goto (macro-user-callerid,s,23) -- Executing NoOp("SIP/23456789-0821de80", "Using CallerID "98765432" <98765432>") in new stack -- Executing Set("SIP/23456789-0821de80", "FROMCONTEXT=exten-vm") in new stack -- Executing Set("SIP/23456789-0821de80", "VMBOX=novm") in new stack -- Executing Set("SIP/23456789-0821de80", "EXTTOCALL=300") in new stack -- Executing Set("SIP/23456789-0821de80", "CFUEXT=") in new stack -- Executing Set("SIP/23456789-0821de80", "CFBEXT=") in new stack -- Executing Set("SIP/23456789-0821de80", "RT=") in new stack -- Executing Macro("SIP/23456789-0821de80", "record-enable|300|IN") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "0?2:4") in new stack -- Goto (macro-record-enable,s,4) -- Executing AGI("SIP/23456789-0821de80", "recordingcheck|20080221-175654|1203645383.3") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck recordingcheck|20080221-175654|1203645383.3: Inbound recording not enabled -- AGI Script recordingcheck completed, returning 0 -- Executing NoOp("SIP/23456789-0821de80", "No recording needed") in new stack -- Executing Macro("SIP/23456789-0821de80", "dial||tr|300") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "1?dial") in new stack -- Goto (macro-dial,s,3) -- Executing AGI("SIP/23456789-0821de80", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi dialparties.agi: Starting New Dialparties.agi == Manager 'admin' logged on from 127.0.0.1 dialparties.agi: Caller ID name is '98765432' number is '98765432' dialparties.agi: Methodology of ring is 'none' -- dialparties.agi: Added extension 300 to extension map -- dialparties.agi: Extension 300 cf is disabled -- dialparties.agi: Extension 300 do not disturb is disabled -- dialparties.agi: dbset CALLTRACE/300 to 98765432 == Manager 'admin' logged off from 127.0.0.1 -- AGI Script dialparties.agi completed, returning 0 -- Executing Dial("SIP/23456789-0821de80", "SIP/300||tr") in new stack Destroying call '1f12ce384bfdbe4b03750e6a43dd148b@123.456.789.10' == Everyone is busy/congested at this time (1:0/0/1) -- Executing Set("SIP/23456789-0821de80", "DIALSTATUS=CHANUNAVAIL") in new stack -- Executing Set("SIP/23456789-0821de80", "SV_DIALSTATUS=CHANUNAVAIL") in new stack -- Executing GosubIf("SIP/23456789-0821de80", "0?docfu|1") in new stack -- Executing GosubIf("SIP/23456789-0821de80", "0?docfb|1") in new stack -- Executing Set("SIP/23456789-0821de80", "DIALSTATUS=CHANUNAVAIL") in new stack -- Executing NoOp("SIP/23456789-0821de80", "Voicemail is novm") in new stack -- Executing GotoIf("SIP/23456789-0821de80", "1?s-CHANUNAVAIL|1") in new stack -- Goto (macro-exten-vm,s-CHANUNAVAIL,1) -- Executing PlayTones("SIP/23456789-0821de80", "congestion") in new stack -- Executing Congestion("SIP/23456789-0821de80", "10") in new stack Retransmitting #4 (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport From: "Unknown" ;tag=as6740d2f8 To: Contact: Call-ID: 6ccaccaf282845f572e4ba1442a528e0@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:56:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- Destroying call '6ccaccaf282845f572e4ba1442a528e0@123.456.789.10' <-- SIP read from 111.222.163.170:5060: --- Scheduling destruction of call '368340791@192.168.11.11' in 15000 ms 12 headers, 0 lines Reliably Transmitting (NAT) to 10.987.654.321:1024: OPTIONS sip:300@192.168.1.107:5067 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK1034e03d;rport From: "Unknown" ;tag=as53f2521d To: Contact: Call-ID: 42d41bb21046293c22f8dbd8062a7823@123.456.789.10 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Max-Forwards: 70 Date: Fri, 22 Feb 2008 01:57:04 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 --- == Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 2) exited non-zero on 'SIP/23456789-0821de80' in macro 'exten-vm' == Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 2) exited non-zero on 'SIP/23456789-0821de80' Scheduling destruction of call '787659497@111.222.31.249' in 32000 ms set_destination: Parsing for address/port to send to set_destination: set destination to 111.222.31.243, port 5060 Reliably Transmitting (no NAT) to 111.222.31.243:5060: BYE sip:98765432@111.222.31.249:6889 SIP/2.0 Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport Route: From: ;tag=as21820660 To: ;tag=1808342796 Call-ID: 787659497@111.222.31.249 CSeq: 102 BYE User-Agent: Asterisk PBX Max-Forwards: 70 Content-Length: 0 --- sipc*CLI> <-- SIP read from 111.222.31.243:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport=5060 From: ;tag=as21820660 To: ;tag=1808342796 Call-ID: 787659497@111.222.31.249 CSeq: 102 BYE User-Agent: sip-gw V 3.1.2 070924 Content-Length: 0 --- (8 headers 0 lines) --- sipc*CLI> <-- SIP read from 111.222.31.243:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport=5060 From: ;tag=as21820660 To: ;tag=1808342796 Call-ID: 787659497@111.222.31.249 CSeq: 102 BYE User-Agent: sip-gw V 3.1.2 070924 Content-Length: 0