Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:26 DEBUG[1075071328] chan_sip.c: Checking device state for peer cstomi Mar 11 16:18:26 DEBUG[1075071328] chan_sip.c: Attempting to fetch peer "cstomi" from realtime db Mar 11 16:18:26 VERBOSE[1093454176] logger.c: Scheduling destruction of call 'HGheAsZsCXaVMJ6A@192.168.1.207' in 15000 ms Mar 11 16:18:26 DEBUG[1075071328] devicestate.c: Changing state for SIP/cstomi - state 4 (Invalid) Mar 11 16:18:26 DEBUG[1097181536] app_queue.c: Device 'SIP/cstomi' changed to state '4' (Invalid) Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Auto destroying call 'F37Ubj57lPb2QIwb@192.168.1.137' Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:26 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:26 VERBOSE[1093454176] logger.c: Destroying call 'F37Ubj57lPb2QIwb@192.168.1.137' Mar 11 16:18:27 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: INVITE sip:06203399876@kontaktia.icall.hu SIP/2.0 Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKpxpBlobAhdQ0CZRZ;rport Max-Forwards: 70 User-Agent: PA168S V1.58.004 CFG0 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 Contact: CSeq: 1 INVITE Supported: replaces Content-Type: application/sdp Content-Length: 292 v=0 o=- 91083335 77273440 IN IP4 192.168.1.207 s=SIP CALL c=IN IP4 192.168.1.207 t=0 0 m=audio 10000 RTP/AVP 18 4 0 8 3 101 a=rtpmap:18 G729/8000 a=rtpmap:4 G723/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 0: INVITE sip:06203399876@kontaktia.icall.hu SIP/2.0 (59) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKpxpBlobAhdQ0CZRZ;rport (72) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 2: Max-Forwards: 70 (16) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 3: User-Agent: PA168S V1.58.004 CFG0 (34) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 4: From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF (97) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 5: To: "06203399876" (64) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 6: Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 (39) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 7: Contact: (50) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 8: CSeq: 1 INVITE (14) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 9: Supported: replaces (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 10: Content-Type: application/sdp (29) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 11: Content-Length: 292 (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 12: (0) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: v=0 (3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: o=- 91083335 77273440 IN IP4 192.168.1.207 (42) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: s=SIP CALL (10) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: c=IN IP4 192.168.1.207 (22) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: t=0 0 (5) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: m=audio 10000 RTP/AVP 18 4 0 8 3 101 (36) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:18 G729/8000 (21) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:4 G723/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:3 GSM/8000 (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=fmtp:101 0-15 (15) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: --- (12 headers 13 lines) --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: HGheAsZsCXaVMJ6A@192.168.1.207 Their Tag VBigN8hrhgWwG2sq Our tag: as2d14fe15 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: jGG65B4eRi3fxLPa@192.168.1.109 Their Tag T1yqHnxkWEJt6lwK Our tag: as618b37e1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 502ebbb56c73c2c474c3fd4123b4263c@192.168.1.2 Their Tag as60089239 Our tag: as4a377652 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 2576b5fc090874130699a76e3a96a417@62.77.220.42 Their Tag as7dbd9ac7 Our tag: as60f3a069 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 5c1bfd50-6a20-122b-2880-39a48cb53b8d Their Tag jKX9gmX6mrt6S Our tag: as45efe531 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Allocating new SIP dialog for TL2H23X5QNpIAl9v@192.168.1.207 - INVITE (With RTP) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Begin: parsing SIP "Supported: replaces" Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Found SIP option: -replaces- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Matched SIP option: replaces Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: * SIP extension value: 1 for call TL2H23X5QNpIAl9v@192.168.1.207 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Using INVITE request as basis request - TL2H23X5QNpIAl9v@192.168.1.207 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Sending to 192.168.1.207 : 5060 (NAT) Mar 11 16:18:27 DEBUG[1093454176] acl.c: ##### apply_ha Result: 1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: *** Setting NAT on RTP to 1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Reliably Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKpxpBlobAhdQ0CZRZ;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as70de664f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 1 INVITE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 WWW-Authenticate: Digest algorithm=MD5, realm="icallbox", nonce="5236fce2" Content-Length: 0 --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #16563 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Scheduling destruction of call 'TL2H23X5QNpIAl9v@192.168.1.207' in 15000 ms Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found user 'cstomi-kontaktia' Mar 11 16:18:27 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: ACK sip:06203399876@kontaktia.icall.hu SIP/2.0 Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKpxpBlobAhdQ0CZRZ;rport Max-Forwards: 70 User-Agent: PA168S V1.58.004 CFG0 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as70de664f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 Contact: CSeq: 1 ACK Content-Length: 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 0: ACK sip:06203399876@kontaktia.icall.hu SIP/2.0 (56) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKpxpBlobAhdQ0CZRZ;rport (72) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 2: Max-Forwards: 70 (16) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 3: User-Agent: PA168S V1.58.004 CFG0 (34) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 4: From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF (97) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 5: To: "06203399876" ;tag=as70de664f (79) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 6: Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 (39) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 7: Contact: (50) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 8: CSeq: 1 ACK (11) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 9: Content-Length: 0 (17) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 10: (0) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: --- (10 headers 0 lines) --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: TL2H23X5QNpIAl9v@192.168.1.207 Their Tag 4JH7F8HuYaFTG9yF Our tag: as70de664f Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: **** Received ACK (6) - Command in SIP ACK Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #16563 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Stopping retransmission on 'TL2H23X5QNpIAl9v@192.168.1.207' of Response 1: Match Found Mar 11 16:18:27 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: INVITE sip:06203399876@kontaktia.icall.hu SIP/2.0 Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;rport Max-Forwards: 70 User-Agent: PA168S V1.58.004 CFG0 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 Contact: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@kontaktia.icall.hu", response="3f967893e2d4e9df3d20d375b6ca3da6", algorithm=MD5 CSeq: 2 INVITE Supported: replaces Content-Type: application/sdp Content-Length: 292 v=0 o=- 83610886 94053726 IN IP4 192.168.1.207 s=SIP CALL c=IN IP4 192.168.1.207 t=0 0 m=audio 10000 RTP/AVP 18 4 0 8 3 101 a=rtpmap:18 G729/8000 a=rtpmap:4 G723/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 0: INVITE sip:06203399876@kontaktia.icall.hu SIP/2.0 (59) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;rport (72) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 2: Max-Forwards: 70 (16) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 3: User-Agent: PA168S V1.58.004 CFG0 (34) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 4: From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF (97) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 5: To: "06203399876" (64) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 6: Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 (39) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 7: Contact: (50) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 8: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@kontaktia.icall.hu", response="3f967893e2d4e9df3d20d375b6ca3da6", algorithm=MD5 (197) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 9: CSeq: 2 INVITE (14) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 10: Supported: replaces (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 11: Content-Type: application/sdp (29) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 12: Content-Length: 292 (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 13: (0) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: v=0 (3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: o=- 83610886 94053726 IN IP4 192.168.1.207 (42) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: s=SIP CALL (10) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: c=IN IP4 192.168.1.207 (22) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: t=0 0 (5) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: m=audio 10000 RTP/AVP 18 4 0 8 3 101 (36) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:18 G729/8000 (21) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:4 G723/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:3 GSM/8000 (19) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Line: a=fmtp:101 0-15 (15) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: --- (13 headers 13 lines) --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: TL2H23X5QNpIAl9v@192.168.1.207 Their Tag 4JH7F8HuYaFTG9yF Our tag: as70de664f Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Using INVITE request as basis request - TL2H23X5QNpIAl9v@192.168.1.207 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Sending to 192.168.1.207 : 5060 (NAT) Mar 11 16:18:27 DEBUG[1093454176] acl.c: ##### apply_ha Result: 1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: *** Setting NAT on RTP to 1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found user 'cstomi-kontaktia' Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 18 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 4 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 0 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 8 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 3 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found RTP audio format 101 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Activating RTP on response TL2H23X5QNpIAl9v@192.168.1.207 (1) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Peer audio RTP is at port 192.168.1.207:10000 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Peer audio RTP is at port 192.168.1.207:10000 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format G729 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format G723 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format PCMU Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format PCMA Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format GSM Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Found description format telephone-event Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: T38 state changed to 0 on channel Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Capabilities: us - 0x40e (gsm|ulaw|alaw|ilbc), peer - audio=0x10f (g723|gsm|ulaw|alaw|g729)/video=0x0 (nothing), combined - 0xe (gsm|ulaw|alaw) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Checking SIP call limits for device cstomi-kontaktia Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Updating call counter for incoming call Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Call from user 'cstomi-kontaktia' is 1 out of 1 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Looking for 06203399876 in local-2-kontaktia (domain kontaktia.icall.hu) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: build_route: Contact hop: Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: list_route: hop: Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 2 INVITE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Length: 0 --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:27 DEBUG[1075071328] chan_sip.c: Checking device state for peer cstomi-kontaktia Mar 11 16:18:27 DEBUG[1075071328] devicestate.c: Changing state for SIP/cstomi-kontaktia - state 1 (Not in use) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [06203399876@local-2-kontaktia:1] Proc("SIP/cstomi-kontaktia-6deb", "dialout-1-kontaktia,06203399876") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 2 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: dialout-1-kontaktia Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[1]: 06203399876 Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [s@proc-dialout-1-kontaktia:1] Goto("SIP/cstomi-kontaktia-6deb", "d-1-1-kontaktia") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: d-1-1-kontaktia Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Goto (proc-dialout-1-kontaktia, s, 2) Mar 11 16:18:27 DEBUG[1096382816] app_queue.c: Device 'SIP/cstomi-kontaktia' changed to state '1' (Not in use) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [s@proc-dialout-1-kontaktia:2] Proc("SIP/cstomi-kontaktia-6deb", "dialout-1-1-kontaktia,06203399876") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 2 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: dialout-1-1-kontaktia Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[1]: 06203399876 Mar 11 16:18:27 DEBUG[1097181536] pbx.c: Expression result is '1' Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [s@proc-dialout-1-1-kontaktia:1] GotoIf("SIP/cstomi-kontaktia-6deb", "1?06203399876,1") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 2 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: 1?06203399876 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[1]: 1 Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Goto (proc-dialout-1-1-kontaktia, 06203399876, 1) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [06203399876@proc-dialout-1-1-kontaktia:1] NoOp("SIP/cstomi-kontaktia-6deb", "CDR: destinationtrunkid = 1") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: CDR: destinationtrunkid = 1 Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Executing [06203399876@proc-dialout-1-1-kontaktia:2] Dial("SIP/cstomi-kontaktia-6deb", "SIP/iCall-ASP-kontaktia/06203399876,,T") Mar 11 16:18:27 DEBUG[1097181536] app.c: argc: 3 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[0]: SIP/iCall-ASP-kontaktia/06203399876 Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[1]: Mar 11 16:18:27 DEBUG[1097181536] app.c: argv[2]: T Mar 11 16:18:27 DEBUG[1097181536] app_dial.c: SIMPLE DIAL (NO URL) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - INVITE (With RTP) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Setting NAT on RTP to 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable PROC_DEPTH. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable ARG1. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable PROC_PRIORITY. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable PROC_CONTEXT. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable PROC_EXTEN. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable SIPCALLID. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable SIPUSERAGENT. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable SIPDOMAIN. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable SIPRURI. Mar 11 16:18:27 DEBUG[1097181536] channel.c: Not copying variable SIPURI. Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Outgoing Call for 06203399876 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Updating call counter for outgoing call Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Our T38 capability (12032), joint T38 capability (12032) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: We're at 62.77.220.42 port 16164 Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Adding codec 0x8 (alaw) to SDP Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Adding codec 0x2 (gsm) to SDP Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Adding codec 0x400 (ilbc) to SDP Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Adding codec 0x200 (speex) to SDP Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Adding non-codec 0x1 (telephone-event) to SDP Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 0: INVITE sip:06203399876@217.116.32.20:5061 SIP/2.0 (50) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK046e822d;rport (63) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 3: To: (41) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 4: Contact: (47) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 5: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 6: CSeq: 102 INVITE (16) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 7: User-Agent: iCallBox (20) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 8: Max-Forwards: 70 (16) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 9: Date: Tue, 11 Mar 2008 15:18:27 GMT (35) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 10: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 11: Content-Type: application/sdp (29) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 12: Content-Length: 0 (17) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Header 13: (0) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: v=0 (3) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: o=root 3227 3227 IN IP4 62.77.220.42 (36) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: s=session (9) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: c=IN IP4 62.77.220.42 (21) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: t=0 0 (5) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: m=audio 16164 RTP/AVP 8 3 97 110 101 (36) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=rtpmap:3 GSM/8000 (19) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=rtpmap:97 iLBC/8000 (21) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=rtpmap:110 speex/8000 (23) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=fmtp:101 0-16 (15) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: 13 headers, 13 lines Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: Reliably Transmitting (no NAT) to 217.116.32.20:5061: INVITE sip:06203399876@217.116.32.20:5061 SIP/2.0 Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK046e822d;rport From: "cstomi" ;tag=as1ed5f7e8 To: Contact: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 102 INVITE User-Agent: iCallBox Max-Forwards: 70 Date: Tue, 11 Mar 2008 15:18:27 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Type: application/sdp Content-Length: 292 v=0 o=root 3227 3227 IN IP4 62.77.220.42 s=session c=IN IP4 62.77.220.42 t=0 0 m=audio 16164 RTP/AVP 8 3 97 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #16565 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1097181536] logger.c: -- Called iCall-ASP-kontaktia/06203399876 Mar 11 16:18:27 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:27 DEBUG[1097181536] channel.c: Set channel SIP/cstomi-kontaktia-6deb to write format gsm Mar 11 16:18:27 DEBUG[1097181536] channel.c: Set channel SIP/cstomi-kontaktia-6deb to read format slin Mar 11 16:18:27 DEBUG[1097181536] channel.c: Set channel SIP/iCall-ASP-kontaktia-6c54 to write format slin Mar 11 16:18:27 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK046e822d;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as4a7b24a3 Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 102 INVITE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Proxy-Authenticate: Digest algorithm=MD5, realm="eworldcom.net", nonce="69ccd167" Content-Length: 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 407 Proxy Authentication Required (41) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK046e822d;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 3: To: ;tag=as4a7b24a3 (56) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 102 INVITE (16) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 8: Proxy-Authenticate: Digest algorithm=MD5, realm="eworldcom.net", nonce="69ccd167" (81) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 9: Content-Length: 0 (17) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 10: (0) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: --- (10 headers 0 lines) --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag Our tag: as1ed5f7e8 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Acked pending invite 102 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #16565 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Stopping retransmission on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' of Request 102: Match Found Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: SIP response 407 to standard invite Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Transmitting (no NAT) to 217.116.32.20:5061: ACK sip:06203399876@217.116.32.20:5061 SIP/2.0 Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK046e822d;rport From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as4a7b24a3 Contact: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 102 ACK User-Agent: iCallBox Max-Forwards: 70 Content-Length: 0 --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Auth attempt 1 on INVITE Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: We're at 62.77.220.42 port 16164 Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Adding codec 0x8 (alaw) to SDP Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Adding codec 0x2 (gsm) to SDP Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Adding codec 0x400 (ilbc) to SDP Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Adding codec 0x200 (speex) to SDP Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Adding non-codec 0x1 (telephone-event) to SDP Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: Reliably Transmitting (no NAT) to 217.116.32.20:5061: INVITE sip:06203399876@217.116.32.20:5061 SIP/2.0 Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;rport From: "cstomi" ;tag=as1ed5f7e8 To: Contact: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 INVITE User-Agent: iCallBox Max-Forwards: 70 Proxy-Authorization: Digest username="iCall-ASP-kontaktia", realm="eworldcom.net", algorithm=MD5, uri="sip:06203399876@217.116.32.20:5061", nonce="69ccd167", response="83e6a6adb6b0f3f77304fae5063594f8", opaque="" Date: Tue, 11 Mar 2008 15:18:27 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Type: application/sdp Content-Length: 292 v=0 o=root 3227 3228 IN IP4 62.77.220.42 s=session c=IN IP4 62.77.220.42 t=0 0 m=audio 16164 RTP/AVP 8 3 97 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #16566 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 100 Trying Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 INVITE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 100 Trying (18) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 3: To: (41) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 103 INVITE (16) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 8: Contact: (46) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 9: Content-Length: 0 (17) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Header 10: (0) Mar 11 16:18:27 VERBOSE[1093454176] logger.c: --- (10 headers 0 lines) --- Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag Our tag: as1ed5f7e8 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: *** SIP TIMER: Cancelling retransmission #16566 - INVITE (got response) Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' Request 103: Found Mar 11 16:18:27 DEBUG[1093454176] chan_sip.c: SIP response 100 to standard invite Mar 11 16:18:30 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: OPTIONS sip:s@62.77.220.42 SIP/2.0 Via: SIP/2.0/UDP 217.116.32.20:5061;branch=z9hG4bK58be1646;rport From: "asterisk" ;tag=as692f285b To: Contact: Call-ID: 5d597fb06129812e4429c9ea0bf12de8@217.116.32.20 CSeq: 102 OPTIONS User-Agent: eWorld Com Max-Forwards: 70 Date: Tue, 11 Mar 2008 15:18:30 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Length: 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 0: OPTIONS sip:s@62.77.220.42 SIP/2.0 (34) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 217.116.32.20:5061;branch=z9hG4bK58be1646;rport (65) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 2: From: "asterisk" ;tag=as692f285b (66) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 3: To: (24) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 4: Contact: (43) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 5: Call-ID: 5d597fb06129812e4429c9ea0bf12de8@217.116.32.20 (56) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 6: CSeq: 102 OPTIONS (17) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 7: User-Agent: eWorld Com (22) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 8: Max-Forwards: 70 (16) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 9: Date: Tue, 11 Mar 2008 15:18:30 GMT (35) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 10: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 11: Content-Length: 0 (17) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Header 12: (0) Mar 11 16:18:30 VERBOSE[1093454176] logger.c: --- (12 headers 0 lines) --- Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag Our tag: as1ed5f7e8 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: TL2H23X5QNpIAl9v@192.168.1.207 Their Tag 4JH7F8HuYaFTG9yF Our tag: as20a6197f Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: HGheAsZsCXaVMJ6A@192.168.1.207 Their Tag VBigN8hrhgWwG2sq Our tag: as2d14fe15 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: jGG65B4eRi3fxLPa@192.168.1.109 Their Tag T1yqHnxkWEJt6lwK Our tag: as618b37e1 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 502ebbb56c73c2c474c3fd4123b4263c@192.168.1.2 Their Tag as60089239 Our tag: as4a377652 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 2576b5fc090874130699a76e3a96a417@62.77.220.42 Their Tag as7dbd9ac7 Our tag: as60f3a069 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 5c1bfd50-6a20-122b-2880-39a48cb53b8d Their Tag jKX9gmX6mrt6S Our tag: as45efe531 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Allocating new SIP dialog for 5d597fb06129812e4429c9ea0bf12de8@217.116.32.20 - OPTIONS (No RTP) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: **** Received OPTIONS (3) - Command in SIP OPTIONS Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 VERBOSE[1093454176] logger.c: Looking for s in default (domain 62.77.220.42) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 VERBOSE[1093454176] logger.c: Transmitting (no NAT) to 217.116.32.20:5061: SIP/2.0 404 Not Found Via: SIP/2.0/UDP 217.116.32.20:5061;branch=z9hG4bK58be1646;rport;received=217.116.32.20 From: "asterisk" ;tag=as692f285b To: ;tag=as1b8fc650 Call-ID: 5d597fb06129812e4429c9ea0bf12de8@217.116.32.20 CSeq: 102 OPTIONS User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Accept: application/sdp Content-Length: 0 --- Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:30 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:30 VERBOSE[1093454176] logger.c: Destroying call '5d597fb06129812e4429c9ea0bf12de8@217.116.32.20' Mar 11 16:18:32 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 INVITE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Type: application/sdp Content-Length: 270 v=0 o=root 3185 3185 IN IP4 217.116.32.20 s=session c=IN IP4 217.116.32.20 t=0 0 m=audio 17968 RTP/AVP 8 3 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 183 Session Progress (28) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 3: To: ;tag=as06152660 (56) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 103 INVITE (16) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 8: Contact: (46) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 9: Content-Type: application/sdp (29) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 10: Content-Length: 270 (19) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 11: (0) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: v=0 (3) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: o=root 3185 3185 IN IP4 217.116.32.20 (38) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: s=session (9) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: c=IN IP4 217.116.32.20 (23) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: t=0 0 (5) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: m=audio 17968 RTP/AVP 8 3 110 101 (33) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:3 GSM/8000 (19) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:110 speex/8000 (23) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=fmtp:101 0-16 (15) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Mar 11 16:18:32 VERBOSE[1093454176] logger.c: --- (11 headers 12 lines) --- Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag Our tag: as1ed5f7e8 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' Request 103: Found Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: SIP response 183 to standard invite Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found RTP audio format 8 Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found RTP audio format 3 Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found RTP audio format 110 Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found RTP audio format 101 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Activating RTP on response 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (1) Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Peer audio RTP is at port 217.116.32.20:17968 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Peer audio RTP is at port 217.116.32.20:17968 Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found description format PCMA Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found description format GSM Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found description format speex Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Found description format telephone-event Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: T38 state changed to 0 on channel SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Capabilities: us - 0x60a (gsm|alaw|speex|ilbc), peer - audio=0x20a (gsm|alaw|speex)/video=0x0 (nothing), combined - 0x20a (gsm|alaw|speex) Mar 11 16:18:32 VERBOSE[1093454176] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event) Mar 11 16:18:32 VERBOSE[1097181536] logger.c: -- SIP/iCall-ASP-kontaktia-6c54 is making progress passing it to SIP/cstomi-kontaktia-6deb Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 VERBOSE[1097181536] logger.c: We're at 192.168.1.2 port 10776 Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Adding codec 0x8 (alaw) to SDP Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Adding codec 0x2 (gsm) to SDP Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Adding codec 0x400 (ilbc) to SDP Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Adding codec 0x4 (ulaw) to SDP Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Adding non-codec 0x1 (telephone-event) to SDP Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 2 INVITE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Type: application/sdp Content-Length: 285 v=0 o=root 3227 3227 IN IP4 192.168.1.2 s=session c=IN IP4 192.168.1.2 t=0 0 m=audio 10776 RTP/AVP 8 3 97 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Oooh, format changed to 8 Mar 11 16:18:32 DEBUG[1097181536] channel.c: Set channel SIP/iCall-ASP-kontaktia-6c54 to read format gsm Mar 11 16:18:32 DEBUG[1097181536] channel.c: Set channel SIP/iCall-ASP-kontaktia-6c54 to write format slin Mar 11 16:18:32 DEBUG[1097181536] rtp.c: Ooh, format changed from unknown to alaw Mar 11 16:18:32 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 INVITE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 180 Ringing (19) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 3: To: ;tag=as06152660 (56) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 103 INVITE (16) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 8: Contact: (46) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 9: Content-Length: 0 (17) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Header 10: (0) Mar 11 16:18:32 VERBOSE[1093454176] logger.c: --- (10 headers 0 lines) --- Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag as06152660 Our tag: as1ed5f7e8 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' Request 103: Found Mar 11 16:18:32 DEBUG[1093454176] chan_sip.c: SIP response 180 to standard invite Mar 11 16:18:32 DEBUG[1075071328] chan_sip.c: Checking device state for peer iCall-ASP-kontaktia Mar 11 16:18:32 DEBUG[1075071328] channel.c: Avoiding initial deadlock for 'SIP/iCall-ASP-kontaktia-6c54' Mar 11 16:18:32 VERBOSE[1097181536] logger.c: -- SIP/iCall-ASP-kontaktia-6c54 is ringing Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 VERBOSE[1097181536] logger.c: Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 2 INVITE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Length: 0 --- Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:32 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:32 DEBUG[1075071328] devicestate.c: Changing state for SIP/iCall-ASP-kontaktia - state 6 (Ringing) Mar 11 16:18:32 DEBUG[1096382816] app_queue.c: Device 'SIP/iCall-ASP-kontaktia' changed to state '6' (Ringing) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Auto destroying call 'jGG65B4eRi3fxLPa@192.168.1.109' Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Destroying call 'jGG65B4eRi3fxLPa@192.168.1.109' Mar 11 16:18:33 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 200 OK Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 INVITE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Type: application/sdp Content-Length: 270 v=0 o=root 3185 3186 IN IP4 217.116.32.20 s=session c=IN IP4 217.116.32.20 t=0 0 m=audio 17968 RTP/AVP 8 3 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 200 OK (14) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK4481d354;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 3: To: ;tag=as06152660 (56) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 103 INVITE (16) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 8: Contact: (46) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 9: Content-Type: application/sdp (29) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 10: Content-Length: 270 (19) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Header 11: (0) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: v=0 (3) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: o=root 3185 3186 IN IP4 217.116.32.20 (38) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: s=session (9) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: c=IN IP4 217.116.32.20 (23) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: t=0 0 (5) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: m=audio 17968 RTP/AVP 8 3 110 101 (33) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:3 GSM/8000 (19) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:110 speex/8000 (23) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=fmtp:101 0-16 (15) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: --- (11 headers 12 lines) --- Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag as06152660 Our tag: as1ed5f7e8 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Acked pending invite 103 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Stopping retransmission on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' of Request 103: Match Found Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: SIP response 200 to standard invite Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found RTP audio format 8 Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found RTP audio format 3 Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found RTP audio format 110 Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found RTP audio format 101 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Activating RTP on response 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (1) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Peer audio RTP is at port 217.116.32.20:17968 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Peer audio RTP is at port 217.116.32.20:17968 Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found description format PCMA Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found description format GSM Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found description format speex Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Found description format telephone-event Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: T38 state changed to 0 on channel SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Capabilities: us - 0x60a (gsm|alaw|speex|ilbc), peer - audio=0x20a (gsm|alaw|speex)/video=0x0 (nothing), combined - 0x20a (gsm|alaw|speex) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: build_route: Contact hop: Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: list_route: hop: Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: set_destination: Parsing for address/port to send to Mar 11 16:18:33 VERBOSE[1093454176] logger.c: set_destination: set destination to 217.116.32.20, port 5061 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1093454176] logger.c: Transmitting (no NAT) to 217.116.32.20:5061: ACK sip:06203399876@217.116.32.20:5061 SIP/2.0 Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK1a71ed1b;rport From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Contact: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 103 ACK User-Agent: iCallBox Max-Forwards: 70 Content-Length: 0 --- Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:SIP/iCall-ASP-kontaktia-6c54) Mar 11 16:18:33 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:33 VERBOSE[1097181536] logger.c: -- SIP/iCall-ASP-kontaktia-6c54 answered SIP/cstomi-kontaktia-6deb Mar 11 16:18:33 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:33 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:33 DEBUG[1097181536] channel.c: Set channel SIP/cstomi-kontaktia-6deb to read format alaw Mar 11 16:18:33 DEBUG[1097181536] channel.c: Set channel SIP/iCall-ASP-kontaktia-6c54 to write format alaw Mar 11 16:18:33 DEBUG[1097181536] channel.c: Set channel SIP/iCall-ASP-kontaktia-6c54 to read format alaw Mar 11 16:18:33 DEBUG[1097181536] channel.c: Set channel SIP/cstomi-kontaktia-6deb to write format alaw Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: sip_answer(SIP/cstomi-kontaktia-6deb) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:33 DEBUG[1075071328] chan_sip.c: Checking device state for peer iCall-ASP-kontaktia Mar 11 16:18:33 VERBOSE[1097181536] logger.c: We're at 192.168.1.2 port 10776 Mar 11 16:18:33 DEBUG[1075071328] devicestate.c: Changing state for SIP/iCall-ASP-kontaktia - state 2 (In use) Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Adding codec 0x8 (alaw) to SDP Mar 11 16:18:33 DEBUG[1075071328] chan_sip.c: Checking device state for peer cstomi-kontaktia Mar 11 16:18:33 DEBUG[1075071328] devicestate.c: Changing state for SIP/cstomi-kontaktia - state 1 (Not in use) Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Adding codec 0x2 (gsm) to SDP Mar 11 16:18:33 DEBUG[1096382816] app_queue.c: Device 'SIP/iCall-ASP-kontaktia' changed to state '2' (In use) Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Adding codec 0x400 (ilbc) to SDP Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Adding codec 0x4 (ulaw) to SDP Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Adding non-codec 0x1 (telephone-event) to SDP Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:33 VERBOSE[1097181536] logger.c: Reliably Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKBCd24pbprOZXQbI5;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 2 INVITE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Type: application/sdp Content-Length: 285 v=0 o=root 3227 3228 IN IP4 192.168.1.2 s=session c=IN IP4 192.168.1.2 t=0 0 m=audio 10776 RTP/AVP 8 3 97 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - --- Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #16567 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:33 DEBUG[1097181536] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:33 DEBUG[1096116576] app_queue.c: Device 'SIP/cstomi-kontaktia' changed to state '1' (Not in use) Mar 11 16:18:33 DEBUG[1097181536] channel.c: Attempting native bridge of SIP/cstomi-kontaktia-6deb and SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:34 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: ACK sip:06203399876@192.168.1.2 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKgdFO5PeuPQSkR4Xl;rport Max-Forwards: 70 User-Agent: PA168S V1.58.004 CFG0 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 Contact: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@192.168.1.2", response="23e0573d92f0162ce90e66fb8c978c32", algorithm=MD5 CSeq: 2 ACK Content-Length: 0 Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 0: ACK sip:06203399876@192.168.1.2 SIP/2.0 (39) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKgdFO5PeuPQSkR4Xl;rport (72) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 2: Max-Forwards: 70 (16) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 3: User-Agent: PA168S V1.58.004 CFG0 (34) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 4: From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF (97) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 5: To: "06203399876" ;tag=as20a6197f (79) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 6: Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 (39) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 7: Contact: (50) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 8: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@192.168.1.2", response="23e0573d92f0162ce90e66fb8c978c32", algorithm=MD5 (180) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 9: CSeq: 2 ACK (11) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 10: Content-Length: 0 (17) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Header 11: (0) Mar 11 16:18:34 VERBOSE[1093454176] logger.c: --- (11 headers 0 lines) --- Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag as06152660 Our tag: as1ed5f7e8 Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: TL2H23X5QNpIAl9v@192.168.1.207 Their Tag 4JH7F8HuYaFTG9yF Our tag: as20a6197f Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: **** Received ACK (6) - Command in SIP ACK Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #16567 Mar 11 16:18:34 DEBUG[1093454176] chan_sip.c: Stopping retransmission on 'TL2H23X5QNpIAl9v@192.168.1.207' of Response 2: Match Found Mar 11 16:18:39 VERBOSE[1096915296] logger.c: -- Remote UNIX connection disconnected Mar 11 16:18:39 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: BYE sip:06203399876@192.168.1.2 SIP/2.0 Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKCF2C9BuAXC98qbYx;rport Max-Forwards: 70 User-Agent: PA168S V1.58.004 CFG0 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 Contact: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@192.168.1.2", response="821e73e552b90894c125c5905e470e08", algorithm=MD5 CSeq: 3 BYE Content-Length: 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 0: BYE sip:06203399876@192.168.1.2 SIP/2.0 (39) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKCF2C9BuAXC98qbYx;rport (72) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 2: Max-Forwards: 70 (16) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 3: User-Agent: PA168S V1.58.004 CFG0 (34) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 4: From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF (97) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 5: To: "06203399876" ;tag=as20a6197f (79) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 6: Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 (39) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 7: Contact: (50) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 8: Authorization: Digest username="cstomi-kontaktia", realm="icallbox", nonce="5236fce2", uri="sip:06203399876@192.168.1.2", response="821e73e552b90894c125c5905e470e08", algorithm=MD5 (180) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 9: CSeq: 3 BYE (11) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 10: Content-Length: 0 (17) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 11: (0) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: --- (11 headers 0 lines) --- Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: = No match Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag as06152660 Our tag: as1ed5f7e8 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: TL2H23X5QNpIAl9v@192.168.1.207 Their Tag 4JH7F8HuYaFTG9yF Our tag: as20a6197f Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: **** Received BYE (8) - Command in SIP BYE Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: Sending to 192.168.1.207 : 5060 (NAT) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: Transmitting (NAT) to 217.20.134.23:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.207:5060;branch=z9hG4bKCF2C9BuAXC98qbYx;received=217.20.134.23;rport=5060 From: "cstomi-kontaktia" ;tag=4JH7F8HuYaFTG9yF To: "06203399876" ;tag=as20a6197f Call-ID: TL2H23X5QNpIAl9v@192.168.1.207 CSeq: 3 BYE User-Agent: iCallBox Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Length: 0 X-CallWeaver-HangupCause: Normal Clearing --- Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:SIP/cstomi-kontaktia-6deb) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:39 DEBUG[1097181536] channel.c: Didn't get a frame from channel: SIP/cstomi-kontaktia-6deb Mar 11 16:18:39 DEBUG[1097181536] channel.c: Bridge stops bridging channels SIP/cstomi-kontaktia-6deb and SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:39 DEBUG[1097181536] channel.c: Hanging up channel 'SIP/iCall-ASP-kontaktia-6c54' Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Hangup call SIP/iCall-ASP-kontaktia-6c54, SIP callid 1b609d8837089ec030b928d55fb669a7@62.77.220.42) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: update_call_counter(06203399876) - decrement call limit counter Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Updating call counter for outgoing call Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 VERBOSE[1097181536] logger.c: Scheduling destruction of call '1b609d8837089ec030b928d55fb669a7@62.77.220.42' in 32000 ms Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 VERBOSE[1097181536] logger.c: set_destination: Parsing for address/port to send to Mar 11 16:18:39 VERBOSE[1097181536] logger.c: set_destination: set destination to 217.116.32.20, port 5061 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 VERBOSE[1097181536] logger.c: Reliably Transmitting (no NAT) to 217.116.32.20:5061: BYE sip:06203399876@217.116.32.20:5061 SIP/2.0 Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK447479ac;rport From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Contact: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 104 BYE User-Agent: iCallBox Max-Forwards: 70 Proxy-Authorization: Digest username="iCall-ASP-kontaktia", realm="eworldcom.net", algorithm=MD5, uri="sip:06203399876@217.116.32.20:5061", nonce="69ccd167", response="7825c70918a2e8d22f3c2b3ec386d7b8", opaque="" Content-Length: 0 --- Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #16569 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 DEBUG[1097181536] channel.c: Generator : deactivate after channel unlock (hangup function) Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/iCall-ASP-kontaktia-6c54 Mar 11 16:18:39 DEBUG[1097181536] app_dial.c: Exiting with DIALSTATUS=ANSWER. Mar 11 16:18:39 DEBUG[1075071328] chan_sip.c: Checking device state for peer iCall-ASP-kontaktia Mar 11 16:18:39 DEBUG[1097181536] app_proc.c: Spawn extension (proc-dialout-1-1-kontaktia,06203399876,2) exited non-zero on 'SIP/cstomi-kontaktia-6deb' in proc 'dialout-1-1-kontaktia' Mar 11 16:18:39 DEBUG[1075071328] devicestate.c: Changing state for SIP/iCall-ASP-kontaktia - state 2 (In use) Mar 11 16:18:39 VERBOSE[1097181536] logger.c: == Spawn extension (proc-dialout-1-1-kontaktia, 06203399876, 2) exited non-zero on 'SIP/cstomi-kontaktia-6deb' in proc 'dialout-1-1-kontaktia' Mar 11 16:18:39 DEBUG[1096915296] app_queue.c: Device 'SIP/iCall-ASP-kontaktia' changed to state '2' (In use) Mar 11 16:18:39 DEBUG[1097181536] app_proc.c: Spawn extension (proc-dialout-1-kontaktia,s,2) exited non-zero on 'SIP/cstomi-kontaktia-6deb' in proc 'dialout-1-kontaktia' Mar 11 16:18:39 VERBOSE[1097181536] logger.c: == Spawn extension (proc-dialout-1-kontaktia, s, 2) exited non-zero on 'SIP/cstomi-kontaktia-6deb' in proc 'dialout-1-kontaktia' Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Spawn extension (local-2-kontaktia,06203399876,1) exited non-zero on 'SIP/cstomi-kontaktia-6deb' Mar 11 16:18:39 VERBOSE[1097181536] logger.c: == Spawn extension (local-2-kontaktia, 06203399876, 1) exited non-zero on 'SIP/cstomi-kontaktia-6deb' Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: clid Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '"cstomi" <222>' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: src Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '222' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: dst Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '06203399876' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: dcontext Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'local-2-kontaktia' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: channel Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'SIP/cstomi-kontaktia-6deb' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: dstchannel Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'SIP/iCall-ASP-kontaktia-6c54' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: lastapp Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'Dial' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: lastdata Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'SIP/iCall-ASP-kontaktia/06203399876,,T' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: start Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '2008-03-11 16:18:27' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: answer Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '2008-03-11 16:18:33' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: end Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '2008-03-11 16:18:39' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: duration Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '12' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: billsec Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '6' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: disposition Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'ANSWERED' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: amaflags Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is 'DOCUMENTATION' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: accountcode Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '(null)' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: uniqueid Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '1205248707.575' Mar 11 16:18:39 DEBUG[1097181536] app.c: argc: 1 Mar 11 16:18:39 DEBUG[1097181536] app.c: argv[0]: userfield Mar 11 16:18:39 DEBUG[1097181536] pbx.c: Function result is '(null)' Mar 11 16:18:39 DEBUG[1097181536] cdr_sqlite3.c: CDR SQLITE3 SQL [INSERT INTO cdr (clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata, start,answer,end,duration,billsec,disposition,amaflags, accountcode) VALUES ('"cstomi" <222>', '222', '06203399876', 'local-2-kontaktia', 'SIP/cstomi-kontaktia-6deb', 'SIP/iCall-ASP-kontaktia-6c54', 'Dial', 'SIP/iCall-ASP-kontaktia/06203399876,,T', '2008-03-11 16:18:27', '2008-03-11 16:18:33', '2008-03-11 16:18:39', 12, 6, 4, 3, '')] Mar 11 16:18:39 DEBUG[1097181536] channel.c: Hanging up channel 'SIP/cstomi-kontaktia-6deb' Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Hangup call SIP/cstomi-kontaktia-6deb, SIP callid TL2H23X5QNpIAl9v@192.168.1.207) Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: update_call_counter(cstomi-kontaktia) - decrement call limit counter Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Updating call counter for incoming call Mar 11 16:18:39 DEBUG[1097181536] chan_sip.c: Call from user 'cstomi-kontaktia' removed from call limit 1 Mar 11 16:18:39 DEBUG[1097181536] channel.c: Generator : deactivate after channel unlock (hangup function) Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:39 DEBUG[1097181536] generator.c: Trying to deactivate generator in SIP/cstomi-kontaktia-6deb Mar 11 16:18:39 DEBUG[1075071328] chan_sip.c: Checking device state for peer cstomi-kontaktia Mar 11 16:18:39 DEBUG[1075071328] devicestate.c: Changing state for SIP/cstomi-kontaktia - state 1 (Not in use) Mar 11 16:18:39 DEBUG[1097181536] app_queue.c: Device 'SIP/cstomi-kontaktia' changed to state '1' (Not in use) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: <-- SIP read from 217.116.32.20:5061: SIP/2.0 200 OK Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK447479ac;received=62.77.220.42;rport=5060 From: "cstomi" ;tag=as1ed5f7e8 To: ;tag=as06152660 Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 CSeq: 104 BYE User-Agent: eWorld Com Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 X-Asterisk-HangupCause: Normal Clearing Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 0: SIP/2.0 200 OK (14) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 1: Via: SIP/2.0/UDP 62.77.220.42:5060;branch=z9hG4bK447479ac;received=62.77.220.42;rport=5060 (90) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 2: From: "cstomi" ;tag=as1ed5f7e8 (68) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 3: To: ;tag=as06152660 (56) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 4: Call-ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 (54) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 5: CSeq: 104 BYE (13) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 6: User-Agent: eWorld Com (22) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 7: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 8: Contact: (46) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 9: Content-Length: 0 (17) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 10: X-Asterisk-HangupCause: Normal Clearing (39) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Header 11: (0) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: --- (11 headers 0 lines) --- Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: = Found Their Call ID: 1b609d8837089ec030b928d55fb669a7@62.77.220.42 Their Tag as06152660 Our tag: as1ed5f7e8 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #16569 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Stopping retransmission on '1b609d8837089ec030b928d55fb669a7@62.77.220.42' of Request 104: Match Found Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=RFC3581/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is not needed (default) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: Destroying call '1b609d8837089ec030b928d55fb669a7@62.77.220.42' Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:39 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:39 VERBOSE[1093454176] logger.c: Destroying call 'TL2H23X5QNpIAl9v@192.168.1.207' Mar 11 16:18:41 DEBUG[1093454176] chan_sip.c: Auto destroying call 'HGheAsZsCXaVMJ6A@192.168.1.207' Mar 11 16:18:41 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor debug (no stun) 0 Mar 11 16:18:41 DEBUG[1093454176] chan_sip.c: opbx_sip_ouraddrfor returning 0 Mar 11 16:18:41 DEBUG[1093454176] chan_sip.c: Check nat (client is on local net/peer nat=Always/global nat=RFC3581/Channel:--) Mar 11 16:18:41 DEBUG[1093454176] chan_sip.c: Nat is needed (condition 3) Mar 11 16:18:41 VERBOSE[1093454176] logger.c: Destroying call 'HGheAsZsCXaVMJ6A@192.168.1.207' Mar 11 16:18:42 VERBOSE[1093454176] logger.c: <-- SIP read from 217.20.134.23:5060: Mar 11 16:18:42 VERBOSE[1093454176] logger.c: --- (0 headers 0 lines) Nat keepalive ---