[Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:1] Macro("SIP/5028-00003e12", "user-callerid,SKIPTTL,") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/5028-00003e12", "AMPUSER=5028") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/5028-00003e12", "0?report") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/5028-00003e12", "1?Set(REALCALLERIDNUM=5028)") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/5028-00003e12", "AMPUSER=5028") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/5028-00003e12", "AMPUSERCIDNAME=RSA") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/5028-00003e12", "0?report") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/5028-00003e12", "AMPUSERCID=5028") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/5028-00003e12", "CALLERID(all)="RSA" <5028>") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/5028-00003e12", "0?Set(CHANNEL(language)=)") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/5028-00003e12", "1?continue") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Goto (macro-user-callerid,s,19) [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-user-callerid:19] NoOp("SIP/5028-00003e12", "Using CallerID "RSA" <5028>") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:2] Macro("SIP/5028-00003e12", "pinsets,3,1") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [s@macro-pinsets:1] GotoIf("SIP/5028-00003e12", "1 = 1?cdr,1") in new stack [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Goto (macro-pinsets,cdr,1) [Feb 14 10:40:36] VERBOSE[12999] pbx.c: -- Executing [cdr@macro-pinsets:1] ExecIf("SIP/5028-00003e12", "1?Authenticate(/etc/asterisk/pinset_3,a)") in new stack [Feb 14 10:40:36] VERBOSE[12999] file.c: -- Playing 'agent-pass.alaw' (language 'es') [Feb 14 10:40:39] VERBOSE[12999] file.c: -- Playing 'auth-incorrect.alaw' (language 'es') [Feb 14 10:40:44] VERBOSE[12999] file.c: -- Playing 'auth-thankyou.alaw' (language 'es') [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [cdr@macro-pinsets:2] ExecIf("SIP/5028-00003e12", "1?ResetCDR()") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:3] NoOp("SIP/5028-00003e12", "Calling Out Route: LAB_FIJOS_E_INTERIOR") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:4] Set("SIP/5028-00003e12", "MOHCLASS=none") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:5] Set("SIP/5028-00003e12", "_NODEST=") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:6] Macro("SIP/5028-00003e12", "record-enable,5028,OUT,") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/5028-00003e12", "1?check") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Goto (macro-record-enable,s,4) [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/5028-00003e12", "0?MacroExit()") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/5028-00003e12", "0?Group:OUT") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Goto (macro-record-enable,s,15) [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/5028-00003e12", "0?IN") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:16] ExecIf("SIP/5028-00003e12", "0?MacroExit()") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:17] NoOp("SIP/5028-00003e12", "Recording enable for 5028") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:18] Set("SIP/5028-00003e12", "CALLFILENAME=OUT5028-20110214-104045-1297687235.29472") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:19] Goto("SIP/5028-00003e12", "record") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Goto (macro-record-enable,s,23) [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:23] MixMonitor("SIP/5028-00003e12", "OUT5028-20110214-104045-1297687235.29472.WAV,,") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-record-enable:24] MacroExit("SIP/5028-00003e12", "") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [923597013@from-internal:7] Macro("SIP/5028-00003e12", "dialout-trunk,2,23597013,") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/5028-00003e12", "DIAL_TRUNK=2") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/5028-00003e12", "0?sub-pincheck,s,1") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/5028-00003e12", "0?disabletrunk,1") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/5028-00003e12", "DIAL_NUMBER=23597013") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/5028-00003e12", "DIAL_TRUNK_OPTIONS=Ttrd") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/5028-00003e12", "OUTBOUND_GROUP=OUT_2") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/5028-00003e12", "0?nomax") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/5028-00003e12", "0?chanfull") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/5028-00003e12", "0?skipoutcid") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/5028-00003e12", "DIAL_TRUNK_OPTIONS=Ttd") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/5028-00003e12", "outbound-callerid,2") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/5028-00003e12", "0?Set(CALLERPRES()=)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/5028-00003e12", "0?Set(REALCALLERIDNUM=5028)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/5028-00003e12", "1?normcid") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Goto (macro-outbound-callerid,s,6) [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/5028-00003e12", "USEROUTCID=") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/5028-00003e12", "EMERGENCYCID=") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/5028-00003e12", "TRUNKOUTCID=") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/5028-00003e12", "1?trunkcid") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Goto (macro-outbound-callerid,s,12) [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/5028-00003e12", "0?Set(CALLERID(all)=)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/5028-00003e12", "0?Set(CALLERID(all)=)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/5028-00003e12", "0?Set(CALLERID(all)=)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/5028-00003e12", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/5028-00003e12", "0?sub-flp-2,s,1") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/5028-00003e12", "OUTNUM=23597013") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/5028-00003e12", "custom=DAHDI/g1") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/5028-00003e12", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^none)Ttd)") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/5028-00003e12", "dialout-trunk-predial-hook,") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/5028-00003e12", "") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/5028-00003e12", "0?bypass,1") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/5028-00003e12", "0?customtrunk") in new stack [Feb 14 10:40:45] VERBOSE[12999] pbx.c: -- Executing [s@macro-dialout-trunk:19] Dial("SIP/5028-00003e12", "DAHDI/g1/23597013,300,M(setmusic^none)Ttd") in new stack [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: -- Making new call for cref 42819 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: -- Requested transfer capability: 0x00 - SPEECH [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > DL-DATA request [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Protocol Discriminator: Q.931 (8) len=34 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 10051/0x2743) (Sent from originator) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Message Type: SETUP (5) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: TEI=0 Transmitting N(S)=26, window is open V(A)=26 K=7 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Protocol Discriminator: Q.931 (8) len=34 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 10051/0x2743) (Sent from originator) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Message Type: SETUP (5) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > [04 03 80 90 a3] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > User information layer 1: A-Law (35) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > [18 03 a1 83 8b] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Preferred Dchan: 0 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > ChanSel: As indicated in following octets [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3 [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Ext: 1 Channel: 11 Type: CPE] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > [6c 06 21 80 35 30 32 38] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Calling Number (len= 8) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Presentation: Presentation permitted, user number not screened (0) '5028' ] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > [70 09 80 32 33 35 39 37 30 31 33] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: > Called Number (len=11) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '23597013' ] [Feb 14 10:40:45] VERBOSE[12999] chan_dahdi.c: q931.c:5039 q931_setup: Call 42819 enters state 1 (Call Initiated). Hold state: Idle [Feb 14 10:40:45] VERBOSE[12999] app_dial.c: -- Called g1/23597013 [Feb 14 10:40:45] VERBOSE[12999] app_dial.c: -- DAHDI/11-1 is proceeding passing it to SIP/5028-00003e12 [Feb 14 10:40:45] VERBOSE[12999] app_dial.c: -- DAHDI/11-1 is ringing [Feb 14 10:40:48] VERBOSE[12999] app_dial.c: -- DAHDI/11-1 answered SIP/5028-00003e12 [Feb 14 10:40:48] VERBOSE[12999] pbx.c: -- Executing [s@macro-setmusic:1] NoOp("DAHDI/11-1", "Setting Outbound Route MoH To: none") in new stack [Feb 14 10:40:48] VERBOSE[12999] pbx.c: -- Executing [s@macro-setmusic:2] SetMusicOnHold("DAHDI/11-1", "none") in new stack OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK2c1826fb;rport Max-Forwards: 70 From: "Unknown" ;tag=as5b5173a1 To: Contact: Call-ID: 217efc1a525d48bb70fa21ac2327adad@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:40:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as5b5173a1 Call-ID: 217efc1a525d48bb70fa21ac2327adad@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK2c1826fb Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:41:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK415e549a;rport Max-Forwards: 70 From: "Unknown" ;tag=as35d66a68 To: Contact: Call-ID: 10647a2810f67dd61373d96769386e46@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:41:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as35d66a68 Call-ID: 10647a2810f67dd61373d96769386e46@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK415e549a Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces --- [Feb 14 10:42:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK12b82e4b;rport Max-Forwards: 70 From: "Unknown" ;tag=as3fb0cde6 To: Contact: Call-ID: 49c2d8a55796351747c770416fd6346d@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:42:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as3fb0cde6 Call-ID: 49c2d8a55796351747c770416fd6346d@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK12b82e4b Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:43:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK0a7ca7b5;rport Max-Forwards: 70 From: "Unknown" ;tag=as32214784 To: Contact: Call-ID: 078c2dcc38bc8e2833eb3f3038a62b40@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:43:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 [Feb 14 10:43:50] VERBOSE[28433] chan_sip.c: <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as32214784 Call-ID: 078c2dcc38bc8e2833eb3f3038a62b40@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK0a7ca7b5 Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK280376bb;rport Max-Forwards: 70 From: "Unknown" ;tag=as5773e89b To: Contact: Call-ID: 35b8d09a264852de276fbeea17cc5607@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:44:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as5773e89b Call-ID: 35b8d09a264852de276fbeea17cc5607@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK280376bb Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:45:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK1cb9f847;rport Max-Forwards: 70 From: "Unknown" ;tag=as2b164df5 To: Contact: Call-ID: 3bcc14ea63d2edd4450458271747d4d2@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:45:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 [Feb 14 10:45:50] VERBOSE[28433] chan_sip.c: <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as2b164df5 Call-ID: 3bcc14ea63d2edd4450458271747d4d2@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK1cb9f847 Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:46:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK66d80f69;rport Max-Forwards: 70 From: "Unknown" ;tag=as0bbc8410 To: Contact: Call-ID: 0de1464b14729f1d2ca3be3e0983f73f@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:46:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as0bbc8410 Call-ID: 0de1464b14729f1d2ca3be3e0983f73f@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK66d80f69 Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:47:50] VERBOSE[28433] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: OPTIONS sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK745f161a;rport Max-Forwards: 70 From: "Unknown" ;tag=as2031bbd4 To: Contact: Call-ID: 5d21d7e207c0b0800935920b242bd9ec@192.168.115.201 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 1.6.2.13 Date: Mon, 14 Feb 2011 12:47:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- SIP read from UDP:192.168.115.164:5060 ---> SIP/2.0 200 OK To: ;tag=a32872d4fe413f7bi0 From: "Unknown" ;tag=as2031bbd4 Call-ID: 5d21d7e207c0b0800935920b242bd9ec@192.168.115.201 CSeq: 102 OPTIONS Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK745f161a Server: Linksys/SPA941-5.1.8 Content-Length: 0 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/5028-00003e12", "hangupcall,") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/5028-00003e12", "1?skiprg") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,4) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/5028-00003e12", "1?skipblkvm") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,7) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/5028-00003e12", "1?theend") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,9) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/5028-00003e12", "") in new stack [Feb 14 10:47:53] VERBOSE[12999] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/5028-00003e12' in macro 'hangupcall' [Feb 14 10:47:53] VERBOSE[12999] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/5028-00003e12' [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: q931_hangup: other hangup [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Connect Request, hold-state Idle [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: q931.c:4845 q931_disconnect: Call 42819 enters state 11 (Disconnect Request). Hold state: Idle [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > DL-DATA request [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Protocol Discriminator: Q.931 (8) len=9 [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 10051/0x2743) (Sent from originator) [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Message Type: DISCONNECT (69) [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: TEI=0 Transmitting N(S)=45, window is open V(A)=45 K=7 [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Protocol Discriminator: Q.931 (8) len=9 [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 10051/0x2743) (Sent from originator) [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Message Type: DISCONNECT (69) [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > [08 02 81 90] [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: > Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] [Feb 14 10:47:53] VERBOSE[12999] chan_dahdi.c: -- Hungup 'DAHDI/11-1' [Feb 14 10:47:53] VERBOSE[12999] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/5028-00003e12' in macro 'dialout-trunk' [Feb 14 10:47:53] VERBOSE[12999] pbx.c: == Spawn extension (from-internal, 923597013, 7) exited non-zero on 'SIP/5028-00003e12' [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [h@from-internal:1] Macro("SIP/5028-00003e12", "hangupcall") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/5028-00003e12", "1?skiprg") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,4) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/5028-00003e12", "1?skipblkvm") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,7) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/5028-00003e12", "1?theend") in new stack [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Goto (macro-hangupcall,s,9) [Feb 14 10:47:53] VERBOSE[12999] pbx.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/5028-00003e12", "") in new stack [Feb 14 10:47:53] VERBOSE[12999] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/5028-00003e12' in macro 'hangupcall' [Feb 14 10:47:53] VERBOSE[12999] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/5028-00003e12' [Feb 14 10:47:53] VERBOSE[12999] chan_sip.c: Scheduling destruction of SIP dialog '394dd0661a781c1203dd86302952d96a@192.168.115.201' in 6400 ms (Method: INVITE) [Feb 14 10:47:53] VERBOSE[12999] chan_sip.c: set_destination: Parsing for address/port to send to [Feb 14 10:47:53] VERBOSE[12999] chan_sip.c: set_destination: set destination to 192.168.115.164, port 5060 [Feb 14 10:47:53] VERBOSE[12999] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.115.164:5060: BYE sip:5028@192.168.115.164:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.115.201:5060;branch=z9hG4bK597eca30;rport Max-Forwards: 70 From: "#CallId=34827" ;tag=as44fc64f8 To: ;tag=608c1b87d677dae8i0 Call-ID: 394dd0661a781c1203dd86302952d96a@192.168.115.201 CSeq: 103 BYE User-Agent: Asterisk PBX 1.6.2.13 X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 [Feb 14 15:36:13] VERBOSE[12999] manager.c: == Manager 'admin' logged on from 127.0.0.1 [Feb 14 15:36:13] VERBOSE[12999] manager.c: == Manager 'admin' logged off from 127.0.0.1 [Feb 14 20:18:59] VERBOSE[5501] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:18:59] VERBOSE[5501] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:18:59] VERBOSE[28416] chan_dahdi.c: < TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent to originator) [Feb 14 20:18:59] VERBOSE[28416] chan_dahdi.c: < TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent to originator) [Feb 14 20:19:05] VERBOSE[28416] chan_dahdi.c: < TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent to originator) [Feb 14 20:19:05] VERBOSE[28416] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:19:05] VERBOSE[28416] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:19:59] VERBOSE[28416] chan_dahdi.c: < TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent to originator) [Feb 14 20:19:59] VERBOSE[5501] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:19:59] VERBOSE[5501] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:19:59] VERBOSE[28416] chan_dahdi.c: < TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent to originator) [Feb 14 20:19:59] VERBOSE[28416] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 20:19:59] VERBOSE[28416] chan_dahdi.c: > TEI=0 Call Ref: len= 2 (reference 12999/0x32C7) (Sent from originator) [Feb 14 21:49:11] VERBOSE[12999] manager.c: == Manager 'admin' logged on from 127.0.0.1 [Feb 14 21:49:11] VERBOSE[12999] manager.c: == Manager 'admin' logged off from 127.0.0.1 Call-ID: 494e2b2e412999aa4e8fb8a57ecfa5d7@192.168.115.201 Call-ID: 494e2b2e412999aa4e8fb8a57ecfa5d7@192.168.115.201 [Feb 15 01:03:51] VERBOSE[28433] chan_sip.c: Really destroying SIP dialog '494e2b2e412999aa4e8fb8a57ecfa5d7@192.168.115.201' Method: OPTIONS [Feb 15 05:47:30] VERBOSE[12999] manager.c: == Manager 'admin' logged on from 127.0.0.1 [Feb 15 05:47:30] VERBOSE[12999] manager.c: == Manager 'admin' logged off from 127.0.0.1 [Feb 15 11:26:05] VERBOSE[11473] rtp.c: Sent RTP packet to 192.168.115.150:16420 (type 00, seq 055628, ts 1299992, len 000160) [Feb 15 11:26:09] VERBOSE[11607] rtp.c: Got RTP packet from 192.168.115.166:16438 (type 00, seq 012999, ts 283493775, len 000160) [Feb 15 11:26:10] VERBOSE[11591] rtp.c: Got RTP packet from 192.168.115.69:8004 (type 08, seq 029264, ts 2041299974, len 000160) [Feb 15 11:26:18] VERBOSE[11607] rtp.c: Sent RTP packet to 192.168.115.166:16438 (type 00, seq 003574, ts 129992, len 000160) [Feb 15 11:26:19] VERBOSE[11587] rtp.c: Got RTP packet from 192.168.115.63:8004 (type 08, seq 049304, ts 4105129998, len 000160) [Feb 15 11:26:25] VERBOSE[11039] rtp.c: Sent RTP packet to 192.168.115.145:16400 (type 00, seq 012999, ts 4695464, len 000160) [Feb 15 11:26:37] VERBOSE[11625] rtp.c: Got RTP packet from 192.168.115.90:8004 (type 08, seq 043907, ts 201299962, len 000160) [Feb 15 11:27:18] VERBOSE[10892] rtp.c: Got RTP packet from 192.168.115.49:3002 (type 08, seq 063481, ts 1041299962, len 000160) [Feb 15 11:28:01] VERBOSE[11640] rtp.c: Sent RTP packet to 192.168.115.146:16436 (type 00, seq 012999, ts 507120, len 000160) [Feb 15 11:28:01] VERBOSE[11635] rtp.c: Sent RTP packet to 192.168.115.37:8004 (type 08, seq 012999, ts 557128, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011974, ts 312999155, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011975, ts 312999315, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011976, ts 312999475, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011977, ts 312999635, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011978, ts 312999795, len 000160) [Feb 15 11:28:04] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 011979, ts 312999955, len 000160) [Feb 15 11:28:10] VERBOSE[11690] rtp.c: Sent RTP packet to 192.168.115.90:8004 (type 08, seq 047755, ts 129992, len 000160) [Feb 15 11:28:24] VERBOSE[11619] rtp.c: Got RTP packet from 192.168.115.149:16404 (type 00, seq 012999, ts 313163155, len 000160) [Feb 15 11:28:38] VERBOSE[11706] rtp.c: Got RTP packet from 192.168.115.155:16410 (type 00, seq 012999, ts 204224510, len 000160) [Feb 15 11:28:59] VERBOSE[11728] rtp.c: Got RTP packet from 192.168.115.143:16434 (type 00, seq 016188, ts 460129994, len 000160) [Feb 15 11:30:40] VERBOSE[11868] rtp.c: Sent RTP packet to 192.168.115.63:8004 (type 08, seq 012999, ts 247616, len 000160) [Feb 15 11:30:43] VERBOSE[11877] rtp.c: Got RTP packet from 192.168.115.31:8004 (type 08, seq 012999, ts 1304392120, len 000160) [Feb 15 11:30:50] VERBOSE[11709] rtp.c: Sent RTP packet to 192.168.115.154:16420 (type 00, seq 005703, ts 1299944, len 000160) [Feb 15 11:31:00] VERBOSE[11889] rtp.c: Sent RTP packet to 192.168.115.153:16474 (type 00, seq 026528, ts 129992, len 000160) [Feb 15 11:31:23] VERBOSE[11719] rtp.c: Sent RTP packet to 192.168.115.166:16440 (type 00, seq 064319, ts 1299928, len 000160) [Feb 15 11:31:36] VERBOSE[11919] rtp.c: Got RTP packet from 192.168.115.24:8000 (type 08, seq 046053, ts 619129994, len 000160) [Feb 15 11:32:19] VERBOSE[10892] rtp.c: Got RTP packet from 192.168.115.49:3002 (type 08, seq 012999, ts 1043708602, len 000160) [Feb 15 11:32:24] VERBOSE[11473] rtp.c: Got RTP packet from 192.168.115.150:16420 (type 00, seq 039391, ts 181299973, len 000160) [Feb 15 11:32:32] VERBOSE[11831] rtp.c: Got RTP packet from 192.168.115.146:16440 (type 00, seq 012054, ts 111299923, len 000160) [Feb 15 11:32:51] VERBOSE[11831] rtp.c: Got RTP packet from 192.168.115.146:16440 (type 00, seq 012999, ts 111451123, len 000160) [Feb 15 11:33:15] VERBOSE[11709] rtp.c: Sent RTP packet to 192.168.115.154:16420 (type 00, seq 012999, ts 2467304, len 000160) [Feb 15 11:33:37] VERBOSE[12051] rtp.c: Got RTP packet from 192.168.115.92:8004 (type 08, seq 015728, ts 2786129994, len 000160) [Feb 15 11:33:41] VERBOSE[12056] rtp.c: Sent RTP packet to 192.168.115.167:16398 (type 00, seq 046626, ts 129992, len 000160) [Feb 15 11:33:55] VERBOSE[12062] rtp.c: Got RTP packet from 192.168.115.155:16426 (type 00, seq 012999, ts 24309086, len 000160) [Feb 15 11:33:59] VERBOSE[11942] rtp.c: Sent RTP packet to 192.168.115.63:8004 (type 08, seq 000067, ts 1299904, len 000160) [Feb 15 11:34:09] VERBOSE[11942] rtp.c: Got RTP packet from 192.168.115.63:8004 (type 08, seq 012999, ts 3682717434, len 000160) [Feb 15 11:34:39] VERBOSE[12142] rtp.c: Sent RTP packet to 192.168.115.69:8004 (type 08, seq 026848, ts 129992, len 000160) [Feb 15 11:35:09] VERBOSE[12150] rtp.c: Sent RTP packet to 192.168.115.31:8004 (type 08, seq 012999, ts 247256, len 000160) [Feb 15 11:35:20] VERBOSE[12008] rtp.c: Got RTP packet from 192.168.115.144:16426 (type 00, seq 012999, ts 233164365, len 000160) [Feb 15 11:35:23] VERBOSE[12176] rtp.c: Sent RTP packet to 192.168.115.167:16400 (type 00, seq 015216, ts 129992, len 000160) [Feb 15 11:35:33] VERBOSE[12008] rtp.c: Sent RTP packet to 192.168.115.144:16426 (type 00, seq 043271, ts 1299936, len 000160) [Feb 17 10:37:01] VERBOSE[12999] manager.c: == Manager 'admin' logged on from 127.0.0.1 [Feb 17 10:37:01] VERBOSE[12999] manager.c: == Manager 'admin' logged off from 127.0.0.1