[May 18 07:36:21] VERBOSE[21424] chan_sip.c: <--- SIP read from UDP:192.168.0.246:5060 ---> REGISTER sip:192.168.0.3 SIP/2.0 Via: SIP/2.0/UDP 192.168.0.246:5060;rport;branch=z9hG4bKPja7ddd10859bc4ab98bc1a48185369af8 Max-Forwards: 70 From: ;tag=710487a3b9114c46b7c060655bf81332 To: Call-ID: 4811a43a32b0462ea6629ceabe4875b3 CSeq: 12011 REGISTER User-Agent: Sipek on PJSUA v1.10.0/win32 Contact: Expires: 3600 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 <-------------> [May 18 07:36:21] VERBOSE[21424] chan_sip.c: --- (12 headers 0 lines) --- [May 18 07:36:21] VERBOSE[21424] chan_sip.c: Sending to 192.168.0.246:5060 (no NAT) [May 18 07:36:21] NOTICE[21424] chan_sip.c: Still have a QUALIFY dialog active, deleting [May 18 07:36:21] VERBOSE[21424] chan_sip.c: Really destroying SIP dialog '6d612cd9422794cc24362c623755e891@192.168.0.3:5060' Method: OPTIONS [May 18 07:36:21] VERBOSE[21424] chan_sip.c: Reliably Transmitting (NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK55792553;rport Max-Forwards: 70 From: "asterisk" ;tag=as6b6d8b44 To: Contact: Call-ID: 49667e6026609bff1c8b5f454e1b91ba@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:21 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 --- [May 18 07:36:21] VERBOSE[21424] chan_sip.c: <--- Transmitting (NAT) to 192.168.0.246:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.0.246:5060;branch=z9hG4bKPja7ddd10859bc4ab98bc1a48185369af8;received=192.168.0.246;rport=5060 From: ;tag=710487a3b9114c46b7c060655bf81332 To: ;tag=as6458e70f Call-ID: 4811a43a32b0462ea6629ceabe4875b3 CSeq: 12011 REGISTER Server: voip1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Expires: 180 Contact: ;expires=180 Date: Wed, 18 May 2011 04:36:21 GMT Content-Length: 0 <------------> [May 18 07:36:21] VERBOSE[21424] chan_sip.c: Scheduling destruction of SIP dialog '4811a43a32b0462ea6629ceabe4875b3' in 32000 ms (Method: REGISTER) [May 18 07:36:21] VERBOSE[21424] chan_sip.c: <--- SIP read from UDP:192.168.0.246:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.0.3:5060;rport=5060;received=192.168.0.3;branch=z9hG4bK55792553 Call-ID: 49667e6026609bff1c8b5f454e1b91ba@192.168.0.3:5060 From: "asterisk" ;tag=as6b6d8b44 To: ;tag=z9hG4bK55792553 CSeq: 102 OPTIONS Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Accept: application/sdp, application/pidf+xml, application/xpidf+xml, application/simple-message-summary, message/sipfrag;version=2.0, application/im-iscomposing+xml, text/plain Supported: replaces, 100rel, timer, norefersub Allow-Events: presence, message-summary, refer User-Agent: Sipek on PJSUA v1.10.0/win32 Content-Type: application/sdp Content-Length: 442 v=0 o=- 3514692984 3514692984 IN IP4 192.168.0.246 s=pjmedia c=IN IP4 192.168.0.246 t=0 0 m=audio 4000 RTP/AVP 98 97 99 104 3 0 8 9 96 a=rtcp:4001 IN IP4 192.168.0.246 a=rtpmap:98 speex/16000 a=rtpmap:97 speex/8000 a=rtpmap:99 speex/32000 a=rtpmap:104 iLBC/8000 a=fmtp:104 mode=30 a=rtpmap:3 GSM/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:9 G722/8000 a=sendrecv a=rtpmap:96 telephone-event/8000 a=fmtp:96 0-15 <-------------> [May 18 07:36:21] VERBOSE[21424] chan_sip.c: --- (13 headers 19 lines) --- [May 18 07:36:21] NOTICE[21424] chan_sip.c: Peer '201' is now Reachable. (1ms / 2000ms) [May 18 07:36:28] VERBOSE[21424] chan_sip.c: <--- SIP read from UDP:192.168.0.246:5060 ---> REGISTER sip:192.168.0.3 SIP/2.0 Via: SIP/2.0/UDP 192.168.0.246:5060;rport;branch=z9hG4bKPj9469678321b140f4b17a5d8fd7787794 Max-Forwards: 70 From: ;tag=1a50354791564222be7da8743747862e To: Call-ID: 4811a43a32b0462ea6629ceabe4875b3 CSeq: 12012 REGISTER User-Agent: Sipek on PJSUA v1.10.0/win32 Contact: Expires: 0 Content-Length: 0 <-------------> [May 18 07:36:28] VERBOSE[21424] chan_sip.c: --- (11 headers 0 lines) --- [May 18 07:36:28] VERBOSE[21424] chan_sip.c: Sending to 192.168.0.246:5060 (NAT) [May 18 07:36:28] VERBOSE[21424] chan_sip.c: -- Unregistered SIP '201' [May 18 07:36:28] VERBOSE[21424] chan_sip.c: <--- Transmitting (NAT) to 192.168.0.246:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.0.246:5060;branch=z9hG4bKPj9469678321b140f4b17a5d8fd7787794;received=192.168.0.246;rport=5060 From: ;tag=1a50354791564222be7da8743747862e To: ;tag=as6458e70f Call-ID: 4811a43a32b0462ea6629ceabe4875b3 CSeq: 12012 REGISTER Server: voip1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Expires: 180 Contact: ;expires=180 Date: Wed, 18 May 2011 04:36:28 GMT Content-Length: 0 <--- SIP read from UDP:192.168.0.101:5060 ---> INVITE sip:201@voip1.intranet.topfactoring.ro SIP/2.0 Via: SIP/2.0/UDP 192.168.0.101:5060;branch=z9hG4bK-c4e8b6c6 From: "200" ;tag=5362e22db1045ad6o0 To: "201" Call-ID: fe7f2a39-f5fd23a@192.168.0.101 CSeq: 102 INVITE Max-Forwards: 70 Authorization: Digest username="200",realm="asterisk",nonce="2cbec6e6",uri="sip:201@voip1.intranet.topfactoring.ro",algorithm=MD5,response="030ecaba7d7e383a245ece4879edffb5" Contact: "200" Expires: 240 User-Agent: Linksys/SPA921-5.1.8 Content-Length: 403 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Supported: replaces Content-Type: application/sdp v=0 o=- 137030816 137030816 IN IP4 192.168.0.101 s=- c=IN IP4 192.168.0.101 t=0 0 m=audio 16460 RTP/AVP 0 2 4 8 18 96 97 98 101 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:4 G723/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:18 G729a/8000 a=rtpmap:96 G726-40/8000 a=rtpmap:97 G726-24/8000 a=rtpmap:98 G726-16/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 a=sendrecv <-------------> [May 18 07:36:39] VERBOSE[21424] chan_sip.c: --- (15 headers 18 lines) --- [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Sending to 192.168.0.101:5060 (NAT) [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Using INVITE request as basis request - fe7f2a39-f5fd23a@192.168.0.101 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found peer '200' for '200' from 192.168.0.101:5060 [May 18 07:36:39] VERBOSE[21424] netsock2.c: == Using SIP RTP CoS mark 5 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 0 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 2 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 4 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 8 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 18 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 96 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 97 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 98 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found RTP audio format 101 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format PCMU for ID 0 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format G726-32 for ID 2 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format G723 for ID 4 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format PCMA for ID 8 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format G729a for ID 18 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found unknown media description format G726-40 for ID 96 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found unknown media description format G726-24 for ID 97 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found unknown media description format G726-16 for ID 98 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Found audio description format telephone-event for ID 101 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Capabilities: us - (ulaw), peer - audio=(g723|ulaw|alaw|g726|g729)/video=(nothing)/text=(nothing), combined - (ulaw) [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Peer audio RTP is at port 192.168.0.101:16460 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Looking for 201 in phones (domain voip1.intranet.topfactoring.ro) [May 18 07:36:39] VERBOSE[21424] chan_sip.c: list_route: hop: [May 18 07:36:39] VERBOSE[21424] chan_sip.c: <--- Transmitting (NAT) to 192.168.0.101:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.0.101:5060;branch=z9hG4bK-c4e8b6c6;received=192.168.0.101;rport=5060 From: "200" ;tag=5362e22db1045ad6o0 To: "201" Call-ID: fe7f2a39-f5fd23a@192.168.0.101 CSeq: 102 INVITE Server: voip1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Contact: Content-Length: 0 <------------> [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@phones:1] Goto("SIP/200-00000006", "dialintern,201,1") in new stack [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Goto (dialintern,201,1) [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@dialintern:1] Set("SIP/200-00000006", "EXACTCDR=7") in new stack [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@dialintern:2] Set("SIP/200-00000006", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@dialintern:3] MixMonitor("SIP/200-00000006", "1305693399.8.WAV") in new stack [May 18 07:36:39] VERBOSE[21465] app_mixmonitor.c: == Begin MixMonitor Recording SIP/200-00000006 [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@dialintern:4] Set("SIP/200-00000006", "PROVIDERID=0") in new stack [May 18 07:36:39] VERBOSE[21464] pbx.c: -- Executing [201@dialintern:5] ExecIf("SIP/200-00000006", "1?Dial(SIP/201):Hangup(17)") in new stack [May 18 07:36:39] VERBOSE[21464] chan_sip.c: Reliably Transmitting (no NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK2d198d04 Max-Forwards: 70 From: "asterisk" ;tag=as447d5a7f To: Contact: Call-ID: 0a76cac536e1180547f070937829bbe8@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 --- [May 18 07:36:39] VERBOSE[21464] netsock2.c: == Using SIP RTP CoS mark 5 [May 18 07:36:39] VERBOSE[21464] chan_sip.c: Audio is at 5060 [May 18 07:36:39] VERBOSE[21464] chan_sip.c: Adding codec 100003 (ulaw) to SDP [May 18 07:36:39] VERBOSE[21464] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP [May 18 07:36:39] VERBOSE[21464] chan_sip.c: Reliably Transmitting (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:39] VERBOSE[21464] app_dial.c: -- Called SIP/201 [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Retransmitting #1 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:39] VERBOSE[21424] chan_sip.c: Retransmitting #2 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:39] VERBOSE[21424] chan_sip.c: <--- SIP read from UDP:192.168.0.241:5060 ---> <-------------> [May 18 07:36:40] VERBOSE[21424] chan_sip.c: Retransmitting #3 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:40] VERBOSE[21424] chan_sip.c: Retransmitting #1 (no NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK2d198d04 Max-Forwards: 70 From: "asterisk" ;tag=as447d5a7f To: Contact: Call-ID: 0a76cac536e1180547f070937829bbe8@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 --- [May 18 07:36:40] VERBOSE[21424] chan_sip.c: Retransmitting #4 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:41] VERBOSE[21424] chan_sip.c: Retransmitting #2 (no NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK2d198d04 Max-Forwards: 70 From: "asterisk" ;tag=as447d5a7f To: Contact: Call-ID: 0a76cac536e1180547f070937829bbe8@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 [May 18 07:36:42] VERBOSE[21424] chan_sip.c: Retransmitting #3 (no NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK2d198d04 Max-Forwards: 70 From: "asterisk" ;tag=as447d5a7f To: Contact: Call-ID: 0a76cac536e1180547f070937829bbe8@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 --- [May 18 07:36:42] VERBOSE[21424] chan_sip.c: Retransmitting #5 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:43] VERBOSE[21424] chan_sip.c: Retransmitting #4 (no NAT) to 192.168.0.246:5060: OPTIONS sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK2d198d04 Max-Forwards: 70 From: "asterisk" ;tag=as447d5a7f To: Contact: Call-ID: 0a76cac536e1180547f070937829bbe8@192.168.0.3:5060 CSeq: 102 OPTIONS User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Length: 0 --- [May 18 07:36:43] NOTICE[21424] chan_sip.c: Peer '201' is now UNREACHABLE! Last qualify: 1 [May 18 07:36:43] VERBOSE[21424] chan_sip.c: Really destroying SIP dialog '0a76cac536e1180547f070937829bbe8@192.168.0.3:5060' Method: OPTIONS [May 18 07:36:44] VERBOSE[21424] chan_sip.c: [May 18 07:36:45] VERBOSE[21424] chan_sip.c: Retransmitting #6 (NAT) to 192.168.0.246:5060: INVITE sip:201@192.168.0.246:5060;ob SIP/2.0 Via: SIP/2.0/UDP 192.168.0.3:5060;branch=z9hG4bK068c8f06;rport Max-Forwards: 70 From: "200" ;tag=as78d38465 To: Contact: Call-ID: 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 CSeq: 102 INVITE User-Agent: voip1 Date: Wed, 18 May 2011 04:36:39 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces Content-Type: application/sdp Content-Length: 217 v=0 o=root 727989886 727989886 IN IP4 192.168.0.3 s=voip1 c=IN IP4 192.168.0.3 t=0 0 m=audio 15366 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 --- [May 18 07:36:45] WARNING[21424] chan_sip.c: Retransmission timeout reached on transmission 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions Packet timed out after 6400ms with no response [May 18 07:36:45] WARNING[21424] chan_sip.c: Hanging up call 2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060 - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions). [May 18 07:36:45] VERBOSE[21464] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1) [May 18 07:36:45] VERBOSE[21464] pbx.c: -- Auto fallthrough, channel 'SIP/200-00000006' status is 'CHANUNAVAIL' [May 18 07:36:45] VERBOSE[21464] chan_sip.c: <--- Reliably Transmitting (NAT) to 192.168.0.101:5060 ---> SIP/2.0 503 Service Unavailable Via: SIP/2.0/UDP 192.168.0.101:5060;branch=z9hG4bK-c4e8b6c6;received=192.168.0.101;rport=5060 From: "200" ;tag=5362e22db1045ad6o0 To: "201" ;tag=as7b99f938 Call-ID: fe7f2a39-f5fd23a@192.168.0.101 CSeq: 102 INVITE Server: voip1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces X-Asterisk-HangupCause: Protocol error, unspecified X-Asterisk-HangupCauseCode: 111 Content-Length: 0 <------------> [May 18 07:36:45] VERBOSE[21424] chan_sip.c: Really destroying SIP dialog '2bcd7f7b33c9ee7110ed9bf96f099dce@192.168.0.3:5060' Method: INVITE [May 18 07:36:45] VERBOSE[21464] pbx.c: -- Executing [h@dialintern:1] ExecIf("SIP/200-00000006", "0?Set(DialStatus=BUSY)") in new stack [May 18 07:36:45] VERBOSE[21464] pbx.c: -- Executing [h@dialintern:2] UserEvent("SIP/200-00000006", "HangupEvent,UniqueID: 1305693399.8,CauseISDN: 111,CauseCode: ,DialStatus: CHANUNAVAIL") in new stack [May 18 07:36:45] VERBOSE[21464] cdr_pgsql.c: > [INSERT INTO t_voip_cdr ("calldate","clid","src","dst","dcontext","channel","dstchannel","lastapp","lastdata","duration","billsec","disposition","amaflags","accountcode","uniqueid") VALUES ('2011-05-18 07:36:39','"200" <200>','200','201','phones','SIP/200-00000006','SIP/201-00000007','Dial','SIP/201',6,0,'NO ANSWER',3,'200','1305693399.8')] [May 18 07:36:45] VERBOSE[21465] app_mixmonitor.c: == End MixMonitor Recording SIP/200-00000006 [May 18 07:36:45] VERBOSE[21424] chan_sip.c: <--- SIP read from UDP:192.168.0.101:5060 ---> ACK sip:201@voip1.intranet.topfactoring.ro SIP/2.0 Via: SIP/2.0/UDP 192.168.0.101:5060;branch=z9hG4bK-c4e8b6c6 From: "200" ;tag=5362e22db1045ad6o0 To: "201" ;tag=as7b99f938 Call-ID: fe7f2a39-f5fd23a@192.168.0.101 CSeq: 102 ACK Max-Forwards: 70 Authorization: Digest username="200",realm="asterisk",nonce="2cbec6e6",uri="sip:201@voip1.intranet.topfactoring.ro",algorithm=MD5,response="030ecaba7d7e383a245ece4879edffb5" Contact: "200" User-Agent: Linksys/SPA921-5.1.8 Content-Length: 0 <-------------> [May 18 07:36:45] VERBOSE[21424] chan_sip.c: --- (11 headers 0 lines) --- [May 18 07:36:45] VERBOSE[21424] chan_sip.c: Really destroying SIP dialog 'fe7f2a39-f5fd23a@192.168.0.101' Method: ACK