Dec 20 11:50:29 DEBUG[2791938992] chan_sip.c: Allocating new SIP dialog for 80f333a4-d41ce61d-13c4-5f8bb-338a02d5-5f8bb - REGISTER (No RTP) Dec 20 11:50:29 DEBUG[2791938992] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER Dec 20 11:50:29 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 80f333a4-d41ce61d-13c4-5f8bb-338a02d5-5f8bb Their Tag 80ae81d8-d41ce61d-13c4-5f8bb-a93d3d-5f8bb Our tag: as371b26af Dec 20 11:50:29 DEBUG[2791938992] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER Dec 20 11:50:29 DEBUG[2791938992] db.c: SQL [delete from odb where family = 'SIP/Registry' and keys = '10'] Dec 20 11:50:29 DEBUG[2791938992] db.c: SQL [insert into odb values('SIP/Registry','10','212.28.230.29:5060:3600:10:sip:10@212.28.230.29:5060')] Dec 20 11:50:29 VERBOSE[2791938992] logger.c: -- Saved useragent "SpeedTouch 780" for peer 10 Dec 20 11:50:29 DEBUG[2811796400] chan_sip.c: Checking device state for peer 10 Dec 20 11:50:29 DEBUG[2811796400] devicestate.c: Changing state for SIP/10 - state 1 (Not in use) Dec 20 11:50:29 DEBUG[2788035504] app_queue.c: Device 'SIP/10' changed to state '1' (Not in use) Dec 20 11:50:44 DEBUG[2803145648] chan_sip.c: Auto destroying call '80f333a4-d41ce61d-13c4-5f8bb-338a02d5-5f8bb' Dec 20 11:50:57 VERBOSE[2812058544] logger.c: -- Remote UNIX connection Dec 20 11:51:18 VERBOSE[2788035504] logger.c: -- Remote UNIX connection disconnected Dec 20 11:51:46 DEBUG[2791001008] chan_zap.c: Monitor doohicky got event Ring/Answered on channel 1 Dec 20 11:51:46 DEBUG[2811796400] devicestate.c: Changing state for Zap/1 - state 2 (In use) Dec 20 11:51:46 VERBOSE[2788035504] logger.c: -- Starting simple switch on 'Zap/1-1' Dec 20 11:51:46 DEBUG[2787773360] app_queue.c: Device 'Zap/1' changed to state '2' (In use) Dec 20 11:51:50 DEBUG[2788035504] chan_zap.c: DTMF digit: 1 on Zap/1-1 Dec 20 11:51:50 DEBUG[2788035504] chan_zap.c: DTMF digit: 0 on Zap/1-1 Dec 20 11:51:50 DEBUG[2788035504] chan_zap.c: No echo cancellation requested Dec 20 11:51:50 DEBUG[2788035504] pbx.c: Launching 'Dial' Dec 20 11:51:50 VERBOSE[2788035504] logger.c: -- Executing Dial("Zap/1-1", "SIP/10|30|r") in new stack Dec 20 11:51:50 DEBUG[2788035504] app_dial.c: SIMPLE DIAL (NO URL) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - INVITE (With RTP) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Setting NAT on RTP to 1 Dec 20 11:51:50 DEBUG[2788035504] channel.c: Not copying variable STACK-default-10-1. Dec 20 11:51:50 DEBUG[2788035504] channel.c: Not copying variable TRANSFERCAPABILITY. Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Outgoing Call for 10 Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Updating call counter for outgoing call Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Our T38 capability (12032), joint T38 capability (12032) Dec 20 11:51:50 VERBOSE[2788035504] logger.c: We're at 82.140.45.15 port 15964 Dec 20 11:51:50 VERBOSE[2788035504] logger.c: Adding codec 0x8 (alaw) to SDP Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 0: INVITE sip:10@212.28.230.29:5060 SIP/2.0 (40) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 1: Via: SIP/2.0/UDP 82.140.45.15:5060;branch=z9hG4bK7dea5004;rport (63) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 2: From: "test" ;tag=as6be3f3e8 (49) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 3: To: (31) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 4: Contact: (30) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 5: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 6: CSeq: 102 INVITE (16) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 7: User-Agent: OpenPBX (19) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 8: Max-Forwards: 70 (16) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 9: Date: Wed, 20 Dec 2006 10:51:50 GMT (35) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 10: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 11: Content-Type: application/sdp (29) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 12: Content-Length: 0 (17) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Header 13: (0) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: v=0 (3) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: o=root 8653 8653 IN IP4 82.140.45.15 (36) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: s=session (9) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: c=IN IP4 82.140.45.15 (21) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: t=0 0 (5) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: m=audio 15964 RTP/AVP 8 (23) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: a=rtpmap:8 PCMA/8000 (20) Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: Line: a=silenceSupp:off - - - - (25) Dec 20 11:51:50 VERBOSE[2788035504] logger.c: 13 headers, 8 lines Dec 20 11:51:50 VERBOSE[2788035504] logger.c: Reliably Transmitting (NAT) to 212.28.230.29:5060: INVITE sip:10@212.28.230.29:5060 SIP/2.0 Via: SIP/2.0/UDP 82.140.45.15:5060;branch=z9hG4bK7dea5004;rport From: "test" ;tag=as6be3f3e8 To: Contact: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 102 INVITE User-Agent: OpenPBX Max-Forwards: 70 Date: Wed, 20 Dec 2006 10:51:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Content-Type: application/sdp Content-Length: 158 v=0 o=root 8653 8653 IN IP4 82.140.45.15 s=session c=IN IP4 82.140.45.15 t=0 0 m=audio 15964 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=silenceSupp:off - - - - --- Dec 20 11:51:50 DEBUG[2788035504] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #6 Dec 20 11:51:50 VERBOSE[2788035504] logger.c: -- Called 10 Dec 20 11:51:50 DEBUG[2788035504] chan_zap.c: Requested indication 3 on channel Zap/1-1 Dec 20 11:51:50 DEBUG[2811796400] devicestate.c: Changing state for Zap/1 - state 6 (Ringing) Dec 20 11:51:50 DEBUG[2787773360] app_queue.c: Device 'Zap/1' changed to state '6' (Ringing) Dec 20 11:51:50 DEBUG[2811796400] devicestate.c: Changing state for Zap/1 - state 6 (Ringing) Dec 20 11:51:50 DEBUG[2787773360] app_queue.c: Device 'Zap/1' changed to state '6' (Ringing) Dec 20 11:51:50 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: SIP/2.0 180 Ringing From: "test";tag=as6be3f3e8 To: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 102 INVITE Via: SIP/2.0/UDP 82.140.45.15:5060;rport=5060;branch=z9hG4bK7dea5004 Supported: replaces,100rel User-Agent: SpeedTouch 780 Allow: INVITE, ACK, BYE, REFER, NOTIFY, CANCEL, OPTIONS Contact: Content-Length: 0 Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 0: SIP/2.0 180 Ringing (19) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 1: From: "test";tag=as6be3f3e8 (48) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 2: To: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (78) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 102 INVITE (16) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 82.140.45.15:5060;rport=5060;branch=z9hG4bK7dea5004 (68) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 6: Supported: replaces,100rel (26) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 7: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 8: Allow: INVITE, ACK, BYE, REFER, NOTIFY, CANCEL, OPTIONS (55) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 10: Content-Length: 0 (17) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: Header 11: (0) Dec 20 11:51:50 VERBOSE[2791938992] logger.c: --- (11 headers 0 lines) --- Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag Our tag: as6be3f3e8 Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: *** SIP TIMER: Cancelling retransmission #6 - INVITE (got response) Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '7468fbe06fa1302914888aac309c1b35@82.140.45.15' Request 102: Found Dec 20 11:51:50 DEBUG[2791938992] chan_sip.c: SIP response 180 to standard invite Dec 20 11:51:50 DEBUG[2811796400] chan_sip.c: Checking device state for peer 10 Dec 20 11:51:50 DEBUG[2811796400] devicestate.c: Changing state for SIP/10 - state 6 (Ringing) Dec 20 11:51:50 VERBOSE[2788035504] logger.c: -- SIP/10-12fa is ringing Dec 20 11:51:50 DEBUG[2788035504] chan_zap.c: DTMF digit: # on Zap/1-1 Dec 20 11:51:50 DEBUG[2787773360] app_queue.c: Device 'SIP/10' changed to state '6' (Ringing) Dec 20 11:51:54 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: SIP/2.0 200 OK From: "test";tag=as6be3f3e8 To: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 102 INVITE Via: SIP/2.0/UDP 82.140.45.15:5060;rport=5060;branch=z9hG4bK7dea5004 Supported: replaces,100rel User-Agent: SpeedTouch 780 Allow: INVITE, ACK, BYE, REFER, NOTIFY, CANCEL, OPTIONS Contact: Content-Type: application/sdp Content-Length: 128 v=0 o=780 1166619902 1166619902 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 8 a=ptime:20 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 0: SIP/2.0 200 OK (14) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 1: From: "test";tag=as6be3f3e8 (48) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 2: To: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (78) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 102 INVITE (16) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 82.140.45.15:5060;rport=5060;branch=z9hG4bK7dea5004 (68) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 6: Supported: replaces,100rel (26) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 7: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 8: Allow: INVITE, ACK, BYE, REFER, NOTIFY, CANCEL, OPTIONS (55) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 128 (19) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619902 IN IP4 212.28.230.29 (48) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 8 (23) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Line: a=ptime:20 (10) Dec 20 11:51:54 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Acked pending invite 102 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Stopping retransmission on '7468fbe06fa1302914888aac309c1b35@82.140.45.15' of Request 102: Match Found Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: SIP response 200 to standard invite Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Got this other party (o = '780 1166619902 1166619902 IN IP4 212.28.230.29') Dec 20 11:51:54 VERBOSE[2791938992] logger.c: Found RTP audio format 8 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Activating RTP on response 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (1) Dec 20 11:51:54 VERBOSE[2791938992] logger.c: Peer audio RTP is at port 212.28.230.29:18310 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: Peer audio RTP is at port 212.28.230.29:18310 Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: T38 state changed to 0 on channel SIP/10-12fa Dec 20 11:51:54 VERBOSE[2791938992] logger.c: Capabilities: us - 0x8 (alaw), peer - audio=0x8 (alaw)/video=0x0 (nothing), combined - 0x8 (alaw) Dec 20 11:51:54 VERBOSE[2791938992] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x0 (nothing), combined - 0x0 (nothing) Dec 20 11:51:54 DEBUG[2791938992] chan_sip.c: build_route: Contact hop: Dec 20 11:51:54 VERBOSE[2791938992] logger.c: list_route: hop: Dec 20 11:51:54 VERBOSE[2791938992] logger.c: set_destination: Parsing for address/port to send to Dec 20 11:51:54 VERBOSE[2791938992] logger.c: set_destination: set destination to 212.28.230.29, port 5060 Dec 20 11:51:54 VERBOSE[2791938992] logger.c: Transmitting (NAT) to 212.28.230.29:5060: ACK sip:10@212.28.230.29:5060 SIP/2.0 Via: SIP/2.0/UDP 82.140.45.15:5060;branch=z9hG4bK265422d0;rport From: "test" ;tag=as6be3f3e8 To: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Contact: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 102 ACK User-Agent: OpenPBX Max-Forwards: 70 Content-Length: 0 --- Dec 20 11:51:54 VERBOSE[2788035504] logger.c: -- SIP/10-12fa answered Zap/1-1 Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Requested indication -1 on channel Zap/1-1 Dec 20 11:51:54 DEBUG[2788035504] generator.c: Trying to deactivate generator in Zap/1-1 Dec 20 11:51:54 DEBUG[2811796400] chan_sip.c: Checking device state for peer 10 Dec 20 11:51:54 DEBUG[2811796400] devicestate.c: Changing state for SIP/10 - state 2 (In use) Dec 20 11:51:54 DEBUG[2787773360] app_queue.c: Device 'SIP/10' changed to state '2' (In use) Dec 20 11:51:54 DEBUG[2788035504] generator.c: Generator on Zap/1-1 stopped after 0 iterations Dec 20 11:51:54 DEBUG[2788035504] channel.c: Set channel SIP/10-12fa to write format slin Dec 20 11:51:54 DEBUG[2788035504] channel.c: Set channel SIP/10-12fa to read format slin Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Took Zap/1-1 off hook Dec 20 11:51:54 DEBUG[2788035504] rtp.c: Ooh, format changed from unknown to alaw Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Write returned -1 (Resource temporarily unavailable) on channel 1 Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Write returned -1 (Resource temporarily unavailable) on channel 1 Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Write returned -1 (Resource temporarily unavailable) on channel 1 Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Write returned -1 (Resource temporarily unavailable) on channel 1 Dec 20 11:51:54 DEBUG[2811796400] devicestate.c: Changing state for Zap/1 - state 2 (In use) Dec 20 11:51:54 DEBUG[2787773360] app_queue.c: Device 'Zap/1' changed to state '2' (In use) Dec 20 11:51:54 DEBUG[2788035504] chan_zap.c: Write returned -1 (Resource temporarily unavailable) on channel 1 Dec 20 11:51:54 DEBUG[2788035504] rtp.c: Got RTCP report of 68 bytes Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:56 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:57 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:58 NOTICE[2788035504] rtp.c: Unknown RTP codec 127 received Dec 20 11:51:59 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 1 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8dc-88d7456 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 357 v=0 o=780 1166619902 1166619903 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=image 22466 udptl t38 a=T38FaxVersion:0 a=T38MaxBitRate:14400 a=T38FaxFillBitRemoval:0 a=T38FaxTranscodingMMR:0 a=T38FaxTranscodingJBIG:0 a=T38FaxRateManagement:transferredTCF a=T38FaxMaxBuffer:2048 a=T38FaxMaxDatagram:176 a=T38FaxUdpEC:t38UDPRedundancy Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 1 INVITE (14) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8dc-88d7456 (73) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 357 (19) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619903 IN IP4 212.28.230.29 (48) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: m=image 22466 udptl t38 (23) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxVersion:0 (17) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38MaxBitRate:14400 (21) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxFillBitRemoval:0 (24) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxTranscodingMMR:0 (24) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxTranscodingJBIG:0 (25) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxRateManagement:transferredTCF (37) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxMaxBuffer:2048 (22) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxMaxDatagram:176 (23) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=T38FaxUdpEC:t38UDPRedundancy (30) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: --- (12 headers 15 lines) --- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Begin: parsing SIP "Supported: replaces,100rel" Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Found SIP option: -replaces- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Matched SIP option: replaces Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Found SIP option: -100rel- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Matched SIP option: 100rel Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: * SIP extension value: 3 for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Using INVITE request as basis request - 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Sending to 212.28.230.29 : 5060 (NAT) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Got this other party (o = '780 1166619902 1166619903 IN IP4 212.28.230.29') Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Activating RTP on response 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (1) Dec 20 11:51:59 WARNING[2791938992] chan_sip.c: Unknown SDP media type in offer: image 22466 udptl t38 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Transmitting (NAT) to 212.28.230.29:5060: SIP/2.0 488 Not acceptable here Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8dc-88d7456;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 1 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: SIP message could not be handled, bad request: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: ACK sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 1 ACK Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8dc-88d7456 Max-Forwards: 70 User-Agent: SpeedTouch 780 Contact: Content-Length: 0 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 0: ACK sip:10@82.140.45.15 SIP/2.0 (31) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 1 ACK (11) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8dc-88d7456 (73) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 7: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 8: Contact: (36) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 9: Content-Length: 0 (17) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 10: (0) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: --- (10 headers 0 lines) --- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: **** Received ACK (6) - Command in SIP ACK Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Stopping retransmission on '7468fbe06fa1302914888aac309c1b35@82.140.45.15' of Response 1: Match Not Found Dec 20 11:51:59 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Using INVITE request as basis request - 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Sending to 212.28.230.29 : 5060 (NAT) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Got this other party (o = '780 1166619902 1166619904 IN IP4 212.28.230.29') Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Found RTP audio format 0 Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Found RTP audio format 8 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Activating RTP on response 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (1) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Peer audio RTP is at port 212.28.230.29:18310 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Peer audio RTP is at port 212.28.230.29:18310 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: T38 state changed to 0 on channel SIP/10-12fa Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Capabilities: us - 0x8 (alaw), peer - audio=0xc (ulaw|alaw)/video=0x0 (nothing), combined - 0x8 (alaw) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x0 (nothing), combined - 0x0 (nothing) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:51:59 DEBUG[2788035504] rtp.c: Got RTCP report of 68 bytes Dec 20 11:51:59 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:51:59 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:51:59 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:00 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:52:00 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:52:00 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:52:00 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:01 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:02 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:52:02 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:52:02 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:52:02 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:04 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:06 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:52:06 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:52:06 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:52:06 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:09 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:12 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:14 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:52:14 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:52:14 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:52:14 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:18 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:21 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:23 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:27 DEBUG[2788035504] rtp.c: Got RTCP report of 48 bytes Dec 20 11:52:30 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: INVITE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Contact: Content-Type: application/sdp Content-Length: 130 v=0 o=780 1166619902 1166619904 IN IP4 212.28.230.29 s=- c=IN IP4 212.28.230.29 t=0 0 m=audio 18310 RTP/AVP 0 8 a=ptime:30 Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 0: INVITE sip:10@82.140.45.15 SIP/2.0 (34) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 2 INVITE (14) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972 (73) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 9: Contact: (36) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 10: Content-Type: application/sdp (29) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 11: Content-Length: 130 (19) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Header 12: (0) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: v=0 (3) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: o=780 1166619902 1166619904 IN IP4 212.28.230.29 (48) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: s=- (3) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: c=IN IP4 212.28.230.29 (22) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: t=0 0 (5) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: m=audio 18310 RTP/AVP 0 8 (25) Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Line: a=ptime:30 (10) Dec 20 11:52:30 VERBOSE[2791938992] logger.c: --- (12 headers 7 lines) --- Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Ignoring SIP message because of retransmit (INVITE Seqno 2, ours 2) Dec 20 11:52:30 VERBOSE[2791938992] logger.c: Ignoring this INVITE request Dec 20 11:52:30 DEBUG[2791938992] chan_sip.c: Got a SIP re-invite for call 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Dec 20 11:52:31 VERBOSE[2791938992] logger.c: <-- SIP read from 212.28.230.29:5060: BYE sip:10@82.140.45.15 SIP/2.0 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 3 BYE Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f934-17557640-74f347e3 Max-Forwards: 70 Supported: replaces,100rel User-Agent: SpeedTouch 780 Content-Length: 0 Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 0: BYE sip:10@82.140.45.15 SIP/2.0 (31) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 1: From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c (80) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 2: To: "test";tag=as6be3f3e8 (46) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 3: Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 (54) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 4: CSeq: 3 BYE (11) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 5: Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f934-17557640-74f347e3 (74) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 6: Max-Forwards: 70 (16) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 7: Supported: replaces,100rel (26) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 8: User-Agent: SpeedTouch 780 (26) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 9: Content-Length: 0 (17) Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: Header 10: (0) Dec 20 11:52:31 VERBOSE[2791938992] logger.c: --- (10 headers 0 lines) --- Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: = Found Their Call ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 Their Tag 80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c Our tag: as6be3f3e8 Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: **** Received BYE (8) - Command in SIP BYE Dec 20 11:52:31 VERBOSE[2791938992] logger.c: Reliably Transmitting (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:31 DEBUG[2791938992] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #7 Dec 20 11:52:31 VERBOSE[2791938992] logger.c: Sending to 212.28.230.29 : 5060 (NAT) Dec 20 11:52:31 VERBOSE[2791938992] logger.c: Transmitting (NAT) to 212.28.230.29:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f934-17557640-74f347e3;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 3 BYE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Contact: Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:31 DEBUG[2788035504] generator.c: Trying to deactivate generator in SIP/10-12fa Dec 20 11:52:31 DEBUG[2788035504] generator.c: Generator on SIP/10-12fa stopped after 0 iterations Dec 20 11:52:31 DEBUG[2788035504] channel.c: Didn't get a frame from channel: SIP/10-12fa Dec 20 11:52:31 DEBUG[2788035504] channel.c: Bridge stops bridging channels Zap/1-1 and SIP/10-12fa Dec 20 11:52:31 DEBUG[2788035504] channel.c: Hanging up channel 'SIP/10-12fa' Dec 20 11:52:31 DEBUG[2788035504] chan_sip.c: Hangup call SIP/10-12fa, SIP callid 7468fbe06fa1302914888aac309c1b35@82.140.45.15) Dec 20 11:52:31 DEBUG[2788035504] chan_sip.c: update_call_counter(10) - decrement call limit counter Dec 20 11:52:31 DEBUG[2788035504] chan_sip.c: Updating call counter for incoming call Dec 20 11:52:31 DEBUG[2788035504] channel.c: Generator : deactivate after channel unlock (hangup function) Dec 20 11:52:31 DEBUG[2788035504] generator.c: Trying to deactivate generator in SIP/10-12fa Dec 20 11:52:31 DEBUG[2788035504] generator.c: Generator on SIP/10-12fa stopped after 0 iterations Dec 20 11:52:31 DEBUG[2788035504] app_dial.c: Exiting with DIALSTATUS=ANSWER. Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Spawn extension (default,10,1) exited non-zero on 'Zap/1-1' Dec 20 11:52:31 VERBOSE[2788035504] logger.c: == Spawn extension (default, 10, 1) exited non-zero on 'Zap/1-1' Dec 20 11:52:31 DEBUG[2788035504] 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 ('"test" <10>', '10', '10', 'default', 'Zap/1-1', 'SIP/10-12fa', 'Dial', 'SIP/10|30|r', '2006-12-20 11:51:50', '2006-12-20 11:51:54', '2006-12-20 11:52:31', 41, 37, 4, 3, '')] Dec 20 11:52:31 DEBUG[2811796400] chan_sip.c: Checking device state for peer 10 Dec 20 11:52:31 DEBUG[2811796400] devicestate.c: Changing state for SIP/10 - state 1 (Not in use) Dec 20 11:52:31 DEBUG[2787773360] app_queue.c: Device 'SIP/10' changed to state '1' (Not in use) Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '"test" <10>' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '10' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '10' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'default' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'Zap/1-1' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'SIP/10-12fa' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'Dial' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'SIP/10|30|r' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '2006-12-20 11:51:50' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '2006-12-20 11:51:54' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '2006-12-20 11:52:31' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '41' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '37' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'ANSWERED' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is 'DOCUMENTATION' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '(null)' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '1166611906.0' Dec 20 11:52:31 DEBUG[2788035504] pbx.c: Function result is '(null)' Dec 20 11:52:31 DEBUG[2788035504] channel.c: Hanging up channel 'Zap/1-1' Dec 20 11:52:31 DEBUG[2788035504] chan_zap.c: zt_hangup(Zap/1-1) Dec 20 11:52:31 DEBUG[2788035504] chan_zap.c: Hangup: channel: 1 index = 0, normal = 11, callwait = -1, thirdcall = -1 Dec 20 11:52:31 DEBUG[2788035504] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1 Dec 20 11:52:31 DEBUG[2788035504] chan_zap.c: Updated conferencing on 1, with 0 conference users Dec 20 11:52:31 VERBOSE[2788035504] logger.c: -- Hungup 'Zap/1-1' Dec 20 11:52:31 DEBUG[2788035504] channel.c: Generator : deactivate after channel unlock (hangup function) Dec 20 11:52:31 DEBUG[2788035504] generator.c: Trying to deactivate generator in Zap/1-1 Dec 20 11:52:31 DEBUG[2788035504] generator.c: Generator on Zap/1-1 stopped after 0 iterations Dec 20 11:52:31 DEBUG[2811796400] devicestate.c: Changing state for Zap/1 - state 0 (Unknown) Dec 20 11:52:31 DEBUG[2788035504] app_queue.c: Device 'Zap/1' changed to state '0' (Unknown) Dec 20 11:52:31 DEBUG[2791001008] chan_zap.c: Monitor doohicky got event Hook Transition Complete on channel 1 Dec 20 11:52:32 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (1) SIP/2.0 - 1 Dec 20 11:52:32 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 2 to 2000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:32 VERBOSE[2803145648] logger.c: Retransmitting #1 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:33 DEBUG[2791001008] chan_zap.c: Monitor doohicky got event On hook on channel 1 Dec 20 11:52:34 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (2) SIP/2.0 - 1 Dec 20 11:52:34 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 3 to 4000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:34 VERBOSE[2803145648] logger.c: Retransmitting #2 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:38 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (3) SIP/2.0 - 1 Dec 20 11:52:38 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 4 to 4000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:38 VERBOSE[2803145648] logger.c: Retransmitting #3 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:42 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (4) SIP/2.0 - 1 Dec 20 11:52:42 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 5 to 4000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:42 VERBOSE[2803145648] logger.c: Retransmitting #4 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:46 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (5) SIP/2.0 - 1 Dec 20 11:52:46 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 6 to 4000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:46 VERBOSE[2803145648] logger.c: Retransmitting #5 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:50 DEBUG[2803145648] chan_sip.c: SIP TIMER: Rescheduling retransmission #7 (6) SIP/2.0 - 1 Dec 20 11:52:50 DEBUG[2803145648] chan_sip.c: ** SIP timers: Rescheduling retransmission 7 to 4000 ms (t1 500 ms (Retrans id #7)) Dec 20 11:52:50 VERBOSE[2803145648] logger.c: Retransmitting #6 (NAT) to 212.28.230.29:5060: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 212.28.230.29:5060;branch=z9hG4bK-5f914-1754f8f0-f703972;received=212.28.230.29 From: ;tag=80ae84b8-d41ce61d-13c4-5f90c-14fdef9-5f90c To: "test";tag=as6be3f3e8 Call-ID: 7468fbe06fa1302914888aac309c1b35@82.140.45.15 CSeq: 2 INVITE User-Agent: OpenPBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Max-Forwards: 70 Content-Length: 0 X-OpenPBX-HangupCause: Normal Clearing --- Dec 20 11:52:54 WARNING[2803145648] chan_sip.c: Maximum retries exceeded on transmission 7468fbe06fa1302914888aac309c1b35@82.140.45.15 for seqno 2 (Critical Response) Dec 20 11:52:55 VERBOSE[2791938992] logger.c: Destroying call '7468fbe06fa1302914888aac309c1b35@82.140.45.15'