Sep 14 17:37:18 VERBOSE[10596] logger.c: <-- SIP read from 62.116.33.68:5060: INVITE sip:88@voip.sysfrog.org SIP/2.0 Record-Route: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE Contact: gst Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@voip.sysfrog.org", response="b1ab7a3d92f6526b2841ccbdf2898a84", algorithm=MD5 max-forwards: 16 expires: 240 user-agent: Sipura/SPA1001-2.0.13(SEg) supported: x-sipura Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Content-Type: application/sdp Content-Length: 427 v=0 o=- 1779527 1779527 IN IP4 85.124.170.206 s=- c=IN IP4 85.124.170.206 t=0 0 m=audio 7070 RTP/AVP 8 0 2 4 18 96 97 98 100 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:4 G723/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:100 NSE/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 a=sendrecv Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: INVITE sip:88@voip.sysfrog.org SIP/2.0 (38) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Record-Route: (62) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: To: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Contact: gst (37) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@voip.sysfrog.org", response="b1ab7a3d92f6526b2841ccbdf2898a84", algorithm=MD5 (209) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: max-forwards: 16 (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: expires: 240 (12) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: user-agent: Sipura/SPA1001-2.0.13(SEg) (38) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: supported: x-sipura (19) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER (61) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Type: application/sdp (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Length: 427 (19) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: (0) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: v=0 (3) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: o=- 1779527 1779527 IN IP4 85.124.170.206 (41) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: s=- (3) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: c=IN IP4 85.124.170.206 (23) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: t=0 0 (5) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: m=audio 7070 RTP/AVP 8 0 2 4 18 96 97 98 100 101 (48) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:2 G726-32/8000 (23) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:4 G723/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:18 G729a/8000 (22) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:96 G726-40/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:97 G726-24/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:98 G726-16/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:100 NSE/8000 (21) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=fmtp:101 0-15 (15) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=ptime:30 (10) Sep 14 17:37:19 VERBOSE[10596] logger.c: --- (18 headers 19 lines)Sep 14 17:37:19 VERBOSE[10596] logger.c: --- (18 headers 19 lines)--- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Allocating new SIP dialog for 581a8a8b-862d8b7@192.168.0.171 - INVITE (With RTP) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Begin: parsing SIP "Supported: x-sipura" Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Found SIP option: -x-sipura- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Found no match for SIP option: x-sipura (Please file bug report!) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: * SIP extension value: 0 for call 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:19 VERBOSE[10596] logger.c: Using INVITE request as basis request - 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:19 VERBOSE[10596] logger.c: Sending to 62.116.33.68 : 5060 (non-NAT) Sep 14 17:37:19 VERBOSE[10596] logger.c: Found peer 'sipsepp' Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Setting NAT on RTP to 0 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 8 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 0 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 2 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 4 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 18 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 96 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 97 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 98 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 100 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found RTP audio format 101 Sep 14 17:37:19 VERBOSE[10596] logger.c: Peer audio RTP is at port 85.124.170.206:7070 Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Peer audio RTP is at port 85.124.170.206:7070 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format PCMA Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format PCMU Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G726-32 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G723 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G729a Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G726-40 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G726-24 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format G726-16 Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format NSE Sep 14 17:37:19 VERBOSE[10596] logger.c: Found description format telephone-event Sep 14 17:37:19 VERBOSE[10596] logger.c: Capabilities: us - 0x8 (alaw), peer - audio=0x51d (g723|ulaw|alaw|g726|g729|ilbc)/video=0x0 (nothing), combined - 0x8 (alaw) Sep 14 17:37:19 VERBOSE[10596] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Checking SIP call limits for device Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Updating call counter for incoming call Sep 14 17:37:19 VERBOSE[10596] logger.c: Looking for 88 in incoming-sip Sep 14 17:37:19 DEBUG[10596] chan_sip.c: build_route: Record-Route hop: Sep 14 17:37:19 VERBOSE[10596] logger.c: list_route: hop: Sep 14 17:37:19 VERBOSE[10596] logger.c: Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: SIP/2.0 100 Trying (18) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 (81) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: To: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Contact: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: (0) Sep 14 17:37:19 DEBUG[10584] chan_sip.c: Checking device state for DNS host voip.sysfrog.org Sep 14 17:37:19 VERBOSE[10596] logger.c: <-- SIP read from 62.116.33.68:5060: INVITE sip:88@voip.sysfrog.org SIP/2.0 Record-Route: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE Contact: gst Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@voip.sysfrog.org", response="b1ab7a3d92f6526b2841ccbdf2898a84", algorithm=MD5 max-forwards: 16 expires: 240 user-agent: Sipura/SPA1001-2.0.13(SEg) supported: x-sipura Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER Content-Type: application/sdp Content-Length: 427 v=0 o=- 1779527 1779527 IN IP4 85.124.170.206 s=- c=IN IP4 85.124.170.206 t=0 0 m=audio 7070 RTP/AVP 8 0 2 4 18 96 97 98 100 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:4 G723/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:100 NSE/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 a=sendrecv Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: INVITE sip:88@voip.sysfrog.org SIP/2.0 (38) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Record-Route: (62) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: To: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Contact: gst (37) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@voip.sysfrog.org", response="b1ab7a3d92f6526b2841ccbdf2898a84", algorithm=MD5 (209) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: max-forwards: 16 (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: expires: 240 (12) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: user-agent: Sipura/SPA1001-2.0.13(SEg) (38) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: supported: x-sipura (19) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER (61) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Type: application/sdp (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Length: 427 (19) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: (0) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: v=0 (3) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: o=- 1779527 1779527 IN IP4 85.124.170.206 (41) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: s=- (3) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: c=IN IP4 85.124.170.206 (23) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: t=0 0 (5) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: m=audio 7070 RTP/AVP 8 0 2 4 18 96 97 98 100 101 (48) Sep 14 17:37:19 DEBUG[10584] devicestate.c: Changing state for SIP/voip.sysfrog.org - state 2 (In use) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:2 G726-32/8000 (23) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:4 G723/8000 (20) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:18 G729a/8000 (22) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:96 G726-40/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:97 G726-24/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:98 G726-16/8000 (24) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:100 NSE/8000 (21) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=fmtp:101 0-15 (15) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Line: a=ptime:30 (10) Sep 14 17:37:19 VERBOSE[10596] logger.c: --- (18 headers 19 lines)Sep 14 17:37:19 VERBOSE[10596] logger.c: --- (18 headers 19 lines)--- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 102, ours 102) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Begin: parsing SIP "Supported: x-sipura" Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Found SIP option: -x-sipura- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Found no match for SIP option: x-sipura (Please file bug report!) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: * SIP extension value: 0 for call 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:19 VERBOSE[10596] logger.c: Ignoring this INVITE request Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Got a SIP re-invite for call 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:19 VERBOSE[10596] logger.c: Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: SIP/2.0 100 Trying (18) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 (81) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: To: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Contact: (29) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:19 DEBUG[10596] chan_sip.c: Header: (0) Sep 14 17:37:19 DEBUG[10604] pbx.c: Launching 'Dial' Sep 14 17:37:19 VERBOSE[10604] logger.c: -- Executing Dial("SIP/voip.sysfrog.org-0823bd38", "Zap/r1/004369910194306") in new stack Sep 14 17:37:19 DEBUG[10604] chan_zap.c: Using channel 1 Sep 14 17:37:19 DEBUG[10584] devicestate.c: Changing state for Zap/1 - state 2 (In use) Sep 14 17:37:19 DEBUG[10604] channel.c: Not copying variable STACK-incoming-sip-88-1. Sep 14 17:37:19 DEBUG[10604] channel.c: Not copying variable SIPCALLID. Sep 14 17:37:19 DEBUG[10604] channel.c: Not copying variable SIPUSERAGENT. Sep 14 17:37:19 DEBUG[10604] channel.c: Not copying variable SIPDOMAIN. Sep 14 17:37:19 DEBUG[10604] channel.c: Not copying variable SIPURI. Sep 14 17:37:19 VERBOSE[10604] logger.c: -- Requested transfer capability: 0x00 - SPEECH Sep 14 17:37:19 DEBUG[10584] channel.c: Avoiding initial deadlock for 'Zap/1-1' Sep 14 17:37:19 VERBOSE[10604] logger.c: -- Called r1/004369910194306 Sep 14 17:37:19 DEBUG[10604] channel.c: Set channel Zap/1-1 to read format alaw Sep 14 17:37:19 DEBUG[10604] channel.c: Set channel SIP/voip.sysfrog.org-0823bd38 to write format alaw Sep 14 17:37:19 DEBUG[10604] channel.c: Set channel SIP/voip.sysfrog.org-0823bd38 to read format alaw Sep 14 17:37:19 DEBUG[10604] channel.c: Set channel Zap/1-1 to write format alaw Sep 14 17:37:19 DEBUG[10605] app_queue.c: Device 'SIP/voip.sysfrog.org' changed to state '2' (In use) Sep 14 17:37:19 DEBUG[10606] app_queue.c: Device 'Zap/1' changed to state '2' (In use) Sep 14 17:37:19 DEBUG[10584] devicestate.c: Changing state for Zap/1 - state 2 (In use) Sep 14 17:37:19 DEBUG[10607] app_queue.c: Device 'Zap/1' changed to state '2' (In use) Sep 14 17:37:19 VERBOSE[10604] logger.c: We're at 193.83.14.2 port 12526 Sep 14 17:37:19 VERBOSE[10604] logger.c: Answering with capability 0x8 (alaw) Sep 14 17:37:19 VERBOSE[10604] logger.c: Answering with non-codec capability 0x1 (telephone-event) Sep 14 17:37:19 ERROR[10604] chan_sip.c: Can't add SDP to response, since we have no RTP session allocated. Call-ID 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:19 VERBOSE[10604] logger.c: Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Type: application/sdp Content-Length: 214 v=0 o=root 10604 10604 IN IP4 193.83.14.2 s=session c=IN IP4 193.83.14.2 t=0 0 m=audio 12526 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: SIP/2.0 183 Session Progress (28) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 (81) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Contact: (29) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Content-Type: application/sdp (29) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: Content-Length: 214 (19) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Header: (0) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: v=0 (3) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: o=root 10604 10604 IN IP4 193.83.14.2 (37) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: s=session (9) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: c=IN IP4 193.83.14.2 (20) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: t=0 0 (5) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: m=audio 12526 RTP/AVP 8 101 (27) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: a=fmtp:101 0-16 (15) Sep 14 17:37:19 DEBUG[10604] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Sep 14 17:37:19 DEBUG[10604] rtp.c: Ooh, format changed from unknown to alaw Sep 14 17:37:24 DEBUG[10589] chan_zap.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/1 span 1 Sep 14 17:37:24 VERBOSE[10604] logger.c: -- Zap/1-1 is proceeding passing it to SIP/voip.sysfrog.org-0823bd38 Sep 14 17:37:27 DEBUG[10589] chan_zap.c: Queuing frame from PRI_EVENT_PROGRESS on channel 0/1 span 1 Sep 14 17:37:27 VERBOSE[10604] logger.c: -- Zap/1-1 is making progress passing it to SIP/voip.sysfrog.org-0823bd38 Sep 14 17:37:28 DEBUG[10589] chan_zap.c: Enabled echo cancellation on channel 1 Sep 14 17:37:28 DEBUG[10584] channel.c: Avoiding initial deadlock for 'Zap/1-1' Sep 14 17:37:28 VERBOSE[10604] logger.c: -- Zap/1-1 is ringing Sep 14 17:37:28 VERBOSE[10604] logger.c: Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: SIP/2.0 180 Ringing (19) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 (81) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Contact: (29) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:28 DEBUG[10604] chan_sip.c: Header: (0) Sep 14 17:37:28 DEBUG[10584] devicestate.c: Changing state for Zap/1 - state 6 (Ringing) Sep 14 17:37:28 DEBUG[10610] app_queue.c: Device 'Zap/1' changed to state '6' (Ringing) Sep 14 17:37:31 DEBUG[10589] chan_zap.c: Echo cancellation already on Sep 14 17:37:31 DEBUG[10584] channel.c: Avoiding initial deadlock for 'Zap/1-1' Sep 14 17:37:31 VERBOSE[10604] logger.c: -- Zap/1-1 answered SIP/voip.sysfrog.org-0823bd38 Sep 14 17:37:31 DEBUG[10604] channel.c: Set channel SIP/voip.sysfrog.org-0823bd38 to read format alaw Sep 14 17:37:31 DEBUG[10604] channel.c: Set channel Zap/1-1 to write format alaw Sep 14 17:37:31 DEBUG[10604] channel.c: Set channel Zap/1-1 to read format alaw Sep 14 17:37:31 DEBUG[10604] channel.c: Set channel SIP/voip.sysfrog.org-0823bd38 to write format alaw Sep 14 17:37:31 DEBUG[10604] chan_sip.c: sip_answer(SIP/voip.sysfrog.org-0823bd38) Sep 14 17:37:31 VERBOSE[10604] logger.c: We're at 193.83.14.2 port 12526 Sep 14 17:37:31 VERBOSE[10604] logger.c: Answering with capability 0x8 (alaw) Sep 14 17:37:31 VERBOSE[10604] logger.c: Answering with non-codec capability 0x1 (telephone-event) Sep 14 17:37:31 ERROR[10604] chan_sip.c: Can't add SDP to response, since we have no RTP session allocated. Call-ID 581a8a8b-862d8b7@192.168.0.171 Sep 14 17:37:31 VERBOSE[10604] logger.c: Reliably Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 Record-Route: From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 INVITE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Type: application/sdp Content-Length: 214 v=0 o=root 10604 10605 IN IP4 193.83.14.2 s=session c=IN IP4 193.83.14.2 t=0 0 m=audio 12526 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: SIP/2.0 200 OK (14) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK5895.a6f03126.0;received=62.116.33.68 (81) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK5335c918f75de615dd40424b3d4fbcab (83) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-8a048ea3 (59) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Record-Route: (62) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: CSeq: 102 INVITE (16) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Contact: (29) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Content-Type: application/sdp (29) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: Content-Length: 214 (19) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Header: (0) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: v=0 (3) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: o=root 10604 10605 IN IP4 193.83.14.2 (37) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: s=session (9) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: c=IN IP4 193.83.14.2 (20) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: t=0 0 (5) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: m=audio 12526 RTP/AVP 8 101 (27) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: a=fmtp:101 0-16 (15) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Sep 14 17:37:31 DEBUG[10604] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1 Sep 14 17:37:31 DEBUG[10589] chan_zap.c: Echo cancellation already on Sep 14 17:37:31 DEBUG[10584] devicestate.c: Changing state for Zap/1 - state 2 (In use) Sep 14 17:37:31 DEBUG[10584] chan_sip.c: Checking device state for DNS host voip.sysfrog.org Sep 14 17:37:31 DEBUG[10611] app_queue.c: Device 'Zap/1' changed to state '2' (In use) Sep 14 17:37:31 DEBUG[10584] devicestate.c: Changing state for SIP/voip.sysfrog.org - state 2 (In use) Sep 14 17:37:31 DEBUG[10612] app_queue.c: Device 'SIP/voip.sysfrog.org' changed to state '2' (In use) Sep 14 17:37:31 VERBOSE[10596] logger.c: <-- SIP read from 62.116.33.68:5060: ACK sip:88@193.83.14.2 SIP/2.0 Via: SIP/2.0/UDP 62.116.33.68;branch=0 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bKfa14a09418ff633c9b9c8eaa2899172d Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-471c050d From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 102 ACK Contact: gst Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@193.83.14.2", response="fc6a6d085a8ec4a622a1fab45cbf1360", algorithm=MD5 max-forwards: 16 user-agent: Sipura/SPA1001-2.0.13(SEg) Content-Length: 0 Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: ACK sip:88@193.83.14.2 SIP/2.0 (30) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=0 (38) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bKfa14a09418ff633c9b9c8eaa2899172d (83) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-471c050d (59) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: CSeq: 102 ACK (13) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Contact: gst (37) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@193.83.14.2", response="fc6a6d085a8ec4a622a1fab45cbf1360", algorithm=MD5 (204) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: max-forwards: 16 (16) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: user-agent: Sipura/SPA1001-2.0.13(SEg) (38) Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:31 VERBOSE[10596] logger.c: --- (13 headers 0 lines)Sep 14 17:37:31 VERBOSE[10596] logger.c: --- (13 headers 0 lines)--- Sep 14 17:37:31 DEBUG[10596] chan_sip.c: **** Received ACK (6) - Command in SIP ACK Sep 14 17:37:31 DEBUG[10596] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1 Sep 14 17:37:31 DEBUG[10596] chan_sip.c: Stopping retransmission on '581a8a8b-862d8b7@192.168.0.171' of Response 102: Match Found Sep 14 17:37:36 VERBOSE[10596] logger.c: <-- SIP read from 62.116.33.68:5060: BYE sip:88@193.83.14.2 SIP/2.0 Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK6895.2539ce65.0 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK282614ab726046f1e44caabf480f8c76 Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-9f33ac6d From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 103 BYE Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@193.83.14.2", response="ed8751a9a54e40ffcd71a67ce9a63bff", algorithm=MD5 max-forwards: 16 user-agent: Sipura/SPA1001-2.0.13(SEg) Content-Length: 0 Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: BYE sip:88@193.83.14.2 SIP/2.0 (30) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK6895.2539ce65.0 (59) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK282614ab726046f1e44caabf480f8c76 (83) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-9f33ac6d (59) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: CSeq: 103 BYE (13) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Proxy-Authorization: Digest username="gst", realm="voip.sysfrog.org", nonce="4328434aa7b6d32776a09f0d73c81c3ea7dbdda3", uri="sip:88@193.83.14.2", response="ed8751a9a54e40ffcd71a67ce9a63bff", algorithm=MD5 (204) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: max-forwards: 16 (16) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: user-agent: Sipura/SPA1001-2.0.13(SEg) (38) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:36 VERBOSE[10596] logger.c: --- (12 headers 0 lines)Sep 14 17:37:36 VERBOSE[10596] logger.c: --- (12 headers 0 lines)--- Sep 14 17:37:36 DEBUG[10596] chan_sip.c: **** Received BYE (8) - Command in SIP BYE Sep 14 17:37:36 VERBOSE[10596] logger.c: Sending to 62.116.33.68 : 5060 (non-NAT) Sep 14 17:37:36 VERBOSE[10596] logger.c: Transmitting (no NAT) to 62.116.33.68:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK6895.2539ce65.0;received=62.116.33.68 Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK282614ab726046f1e44caabf480f8c76 Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-9f33ac6d From: gst ;tag=be85007ba2515b87o0 To: ;tag=as0797f1b1 Call-ID: 581a8a8b-862d8b7@192.168.0.171 CSeq: 103 BYE User-Agent: EUnet PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 X-Asterisk-HangupCause: Normal Clearing --- Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: SIP/2.0 200 OK (14) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 62.116.33.68;branch=z9hG4bK6895.2539ce65.0;received=62.116.33.68 (81) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 85.124.170.206:5060;branch=z9hG4bK282614ab726046f1e44caabf480f8c76 (83) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Via: SIP/2.0/UDP 192.168.0.171:5060;branch=z9hG4bK-9f33ac6d (59) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: From: gst ;tag=be85007ba2515b87o0 (59) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: To: ;tag=as0797f1b1 (44) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Call-ID: 581a8a8b-862d8b7@192.168.0.171 (39) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: CSeq: 103 BYE (13) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: User-Agent: EUnet PBX (21) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Contact: (29) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: Content-Length: 0 (17) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: X-Asterisk-HangupCause: Normal Clearing (39) Sep 14 17:37:36 DEBUG[10596] chan_sip.c: Header: (0) Sep 14 17:37:36 DEBUG[10604] channel.c: Didn't get a frame from channel: SIP/voip.sysfrog.org-0823bd38 Sep 14 17:37:36 DEBUG[10604] channel.c: Bridge stops bridging channels SIP/voip.sysfrog.org-0823bd38 and Zap/1-1 Sep 14 17:37:36 DEBUG[10604] channel.c: Hanging up channel 'Zap/1-1' Sep 14 17:37:36 DEBUG[10604] chan_zap.c: zt_hangup(Zap/1-1) Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1 Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Hangup: channel: 1 index = 0, normal = 15, callwait = -1, thirdcall = -1 Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call Sep 14 17:37:36 DEBUG[10604] chan_zap.c: disabled echo cancellation on channel 1 Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1 Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Updated conferencing on 1, with 0 conference users Sep 14 17:37:36 DEBUG[10604] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1 Sep 14 17:37:36 DEBUG[10604] chan_zap.c: disabled echo cancellation on channel 1 Sep 14 17:37:36 VERBOSE[10604] logger.c: -- Hungup 'Zap/1-1' Sep 14 17:37:36 DEBUG[10584] devicestate.c: Changing state for Zap/1 - state 0 (Unknown) Sep 14 17:37:36 DEBUG[10613] app_queue.c: Device 'Zap/1' changed to state '0' (Unknown) Sep 14 17:37:36 DEBUG[10604] app_dial.c: Exiting with DIALSTATUS=ANSWER. Sep 14 17:37:36 DEBUG[10604] pbx.c: Spawn extension (incoming-sip,88,1) exited non-zero on 'SIP/voip.sysfrog.org-0823bd38' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '"gst" ' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'gst' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '88' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'incoming-sip' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'SIP/voip.sysfrog.org-0823bd38' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'Zap/1-1' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'Dial' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'Zap/r1/004369910194306' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '2005-09-14 17:37:19' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '2005-09-14 17:37:31' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '2005-09-14 17:37:36' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '17' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '5' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'ANSWERED' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is 'DOCUMENTATION' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '(null)' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '1126712239.0' Sep 14 17:37:36 DEBUG[10604] pbx.c: Function result is '(null)' Sep 14 17:37:36 DEBUG[10604] channel.c: Hanging up channel 'SIP/voip.sysfrog.org-0823bd38' Sep 14 17:37:36 DEBUG[10604] chan_sip.c: Hangup call SIP/voip.sysfrog.org-0823bd38, SIP callid 581a8a8b-862d8b7@192.168.0.171) Sep 14 17:37:36 DEBUG[10604] chan_sip.c: update_call_counter() - decrement call limit counter Sep 14 17:37:36 DEBUG[10604] chan_sip.c: Updating call counter for incoming call Sep 14 17:37:36 DEBUG[10584] chan_sip.c: Checking device state for DNS host voip.sysfrog.org Sep 14 17:37:36 DEBUG[10584] devicestate.c: Changing state for SIP/voip.sysfrog.org - state 1 (Not in use) Sep 14 17:37:36 DEBUG[10614] app_queue.c: Device 'SIP/voip.sysfrog.org' changed to state '1' (Not in use) Sep 14 17:37:37 VERBOSE[10596] logger.c: Destroying call '581a8a8b-862d8b7@192.168.0.171' Sep 14 17:37:37 DEBUG[10596] chan_sip.c: ---------- SIP HISTORY for '581a8a8b-862d8b7@192.168.0.171' Sep 14 17:37:37 DEBUG[10596] chan_sip.c: * SIP Call Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 1. Rx INVITE / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 2. CancelDestroy Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 3. TxResp SIP/2.0 / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 4. Rx INVITE / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 5. TxResp SIP/2.0 / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 6. TxResp SIP/2.0 / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 7. TxResp SIP/2.0 / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 8. TxRespRel SIP/2.0 / 102 INVITE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 9. Rx ACK / 102 ACK Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 10. Rx BYE / 103 BYE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: 11. TxResp SIP/2.0 / 103 BYE Sep 14 17:37:37 DEBUG[10596] chan_sip.c: ---------- END SIP HISTORY for '581a8a8b-862d8b7@192.168.0.171'