rendered paste body/var/log/asterisk/full - last 2000 lines
Jun 11 13:48:07 VERBOSE[3069] logger.c: Asterisk Event Logger restarted
Jun 11 13:48:07 VERBOSE[3069] logger.c: Asterisk Queue Logger restarted
Jun 11 13:48:15 VERBOSE[2180] logger.c:
<-- SIP read from 212.27.52.5:5060:
INVITE sip:s@87.90.132.119:5060;transport=udp SIP/2.0
Allow: UPDATE,REFER
Call-ID: 01-01753-012b3615-34b3404f3@freephonie.net
Contact:
Content-Type: application/sdp
CSeq: 19747685 INVITE
From: ;tag=01-01753-012b3616-21ff30c64
Max-Forwards: 27
To:
User-Agent: Cirpack/v4.40 (gw_sip)
Via: SIP/2.0/UDP 212.27.52.5:5060;branch=z9hG4bK-6D61-9BA55
Content-Length: 170
v=0
o=cp10 115002649542 115002649543 IN IP4 172.25.7.5
s=SIP Call
c=IN IP4 212.27.52.129
t=0 0
m=audio 31116 RTP/AVP 8
b=AS:64
a=rtpmap:8 PCMA/8000/1
a=ptime:30
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 0: INVITE sip:s@87.90.132.119:5060;transport=udp SIP/2.0 (53)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 1: Allow: UPDATE,REFER (19)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 2: Call-ID: 01-01753-012b3615-34b3404f3@freephonie.net (51)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 3: Contact: (31)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 4: Content-Type: application/sdp (29)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 5: CSeq: 19747685 INVITE (21)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 6: From: ;tag=01-01753-012b3616-21ff30c64 (80)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 7: Max-Forwards: 27 (16)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 8: To: (43)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 9: User-Agent: Cirpack/v4.40 (gw_sip) (34)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 10: Via: SIP/2.0/UDP 212.27.52.5:5060;branch=z9hG4bK-6D61-9BA55 (59)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 11: Content-Length: 170 (19)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 12: (0)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: v=0 (3)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: o=cp10 115002649542 115002649543 IN IP4 172.25.7.5 (50)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: s=SIP Call (10)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: c=IN IP4 212.27.52.129 (22)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: t=0 0 (5)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: m=audio 31116 RTP/AVP 8 (23)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: b=AS:64 (7)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: a=rtpmap:8 PCMA/8000/1 (22)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Line: a=ptime:30 (10)
Jun 11 13:48:15 VERBOSE[2180] logger.c: --- (12 headers 9 lines)Jun 11 13:48:15 VERBOSE[2180] logger.c: --- (12 headers 9 lines)---
Jun 11 13:48:15 DEBUG[2180] acl.c: ##### Testing 212.27.52.5 with 192.168.1.0
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Target address 212.27.52.5 is not local, substituting externip
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Allocating new SIP dialog for 01-01753-012b3615-34b3404f3@freephonie.net - INVITE (With RTP)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jun 11 13:48:15 VERBOSE[2180] logger.c: Using INVITE request as basis request - 01-01753-012b3615-34b3404f3@freephonie.net
Jun 11 13:48:15 VERBOSE[2180] logger.c: Sending to 212.27.52.5 : 5060 (NAT)
Jun 11 13:48:15 VERBOSE[2180] logger.c: Found peer 'Free_Out'
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Setting NAT on RTP to 524288
Jun 11 13:48:15 VERBOSE[2180] logger.c: Reliably Transmitting (NAT) to 212.27.52.5:5060:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 212.27.52.5:5060;branch=z9hG4bK-6D61-9BA55;received=212.27.52.5
From: ;tag=01-01753-012b3616-21ff30c64
To: ;tag=as20b0a46e
Call-ID: 01-01753-012b3615-34b3404f3@freephonie.net
CSeq: 19747685 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact:
Proxy-Authenticate: Digest realm="asterisk", nonce="369914f2"
Content-Length: 0
---
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #942
Jun 11 13:48:15 VERBOSE[2180] logger.c: Scheduling destruction of call '01-01753-012b3615-34b3404f3@freephonie.net' in 15000 ms
Jun 11 13:48:15 VERBOSE[2180] logger.c:
<-- SIP read from 212.27.52.5:5060:
ACK sip:s@87.90.132.119:5060;transport=udp SIP/2.0
Call-ID: 01-01753-012b3615-34b3404f3@freephonie.net
Contact:
CSeq: 19747685 ACK
From: ;tag=01-01753-012b3616-21ff30c64
Max-Forwards: 27
To: ;tag=as20b0a46e
Via: SIP/2.0/UDP 212.27.52.5:5060;branch=z9hG4bK-6D61-9BA55
Content-Length: 0
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 0: ACK sip:s@87.90.132.119:5060;transport=udp SIP/2.0 (50)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 1: Call-ID: 01-01753-012b3615-34b3404f3@freephonie.net (51)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 2: Contact: (31)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 3: CSeq: 19747685 ACK (18)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 4: From: ;tag=01-01753-012b3616-21ff30c64 (80)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 5: Max-Forwards: 27 (16)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 6: To: ;tag=as20b0a46e (58)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 7: Via: SIP/2.0/UDP 212.27.52.5:5060;branch=z9hG4bK-6D61-9BA55 (59)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 8: Content-Length: 0 (17)
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Header 9: (0)
Jun 11 13:48:15 VERBOSE[2180] logger.c: --- (9 headers 0 lines)Jun 11 13:48:15 VERBOSE[2180] logger.c: --- (9 headers 0 lines)---
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #942
Jun 11 13:48:15 DEBUG[2180] chan_sip.c: Stopping retransmission on '01-01753-012b3615-34b3404f3@freephonie.net' of Response 19747685: Match Found
Jun 11 13:48:17 VERBOSE[2180] logger.c:
<-- SIP read from 212.27.52.5:5060:
Cirpack KeepAlive Packet
Jun 11 13:48:17 DEBUG[2180] chan_sip.c: Header 0: Cirpack KeepAlive Packet (24)
Jun 11 13:48:17 VERBOSE[2180] logger.c: --- (1 headers 0 lines)Jun 11 13:48:17 VERBOSE[2180] logger.c: --- (1 headers 0 lines)---
Jun 11 13:48:17 VERBOSE[2180] logger.c:
<-- SIP read from 212.27.52.5:5060:
Cirpack KeepAlive Packet
Jun 11 13:48:17 DEBUG[2180] chan_sip.c: Header 0: Cirpack KeepAlive Packet (24)
Jun 11 13:48:17 VERBOSE[2180] logger.c: --- (1 headers 0 lines)Jun 11 13:48:17 VERBOSE[2180] logger.c: --- (1 headers 0 lines)---
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
Jun 11 13:48:28 DEBUG[2180] acl.c: ##### Testing 192.168.1.43 with 192.168.1.0
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 0: OPTIONS sip:1001@192.168.1.43:5061 SIP/2.0 (42)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.11:5060;branch=z9hG4bK70412103;rport (63)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 2: From: "Unknown" ;tag=as0759c746 (57)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 3: To: (32)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 4: Contact: (35)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 5: Call-ID: 6a867137361ce8b2774bbd4d271f31b8@192.168.1.11 (54)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 6: CSeq: 102 OPTIONS (17)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 7: User-Agent: Asterisk PBX (24)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 9: Date: Sun, 11 Jun 2006 11:48:28 GMT (35)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 10: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 12: (0)
Jun 11 13:48:28 VERBOSE[2180] logger.c: 12 headers, 0 lines
Jun 11 13:48:28 VERBOSE[2180] logger.c: Reliably Transmitting (NAT) to 192.168.1.43:5061:
OPTIONS sip:1001@192.168.1.43:5061 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.11:5060;branch=z9hG4bK70412103;rport
From: "Unknown" ;tag=as0759c746
To:
Contact:
Call-ID: 6a867137361ce8b2774bbd4d271f31b8@192.168.1.11
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Sun, 11 Jun 2006 11:48:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #944
Jun 11 13:48:28 VERBOSE[2180] logger.c:
<-- SIP read from 192.168.1.43:5061:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.1.11:5060;branch=z9hG4bK70412103;rport
From: "Unknown" ;tag=as0759c746
To: ;tag=2052935249
Contact:
Call-ID: 6a867137361ce8b2774bbd4d271f31b8@192.168.1.11
Allow: INVITE,ACK,BYE,CANCEL,OPTIONS,NOTIFY
CSeq: 102 OPTIONS
Server: X-Lite release 1105d
Content-Length: 0
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 0: SIP/2.0 200 Ok (14)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.11:5060;branch=z9hG4bK70412103;rport (63)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 2: From: "Unknown" ;tag=as0759c746 (57)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 3: To: ;tag=2052935249 (47)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 4: Contact: (37)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 5: Call-ID: 6a867137361ce8b2774bbd4d271f31b8@192.168.1.11 (54)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 6: Allow: INVITE,ACK,BYE,CANCEL,OPTIONS,NOTIFY (43)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 7: CSeq: 102 OPTIONS (17)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 8: Server: X-Lite release 1105d (28)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 9: Content-Length: 0 (17)
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Header 10: (0)
Jun 11 13:48:28 VERBOSE[2180] logger.c: --- (10 headers 0 lines)Jun 11 13:48:28 VERBOSE[2180] logger.c: --- (10 headers 0 lines)---
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #944
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Stopping retransmission on '6a867137361ce8b2774bbd4d271f31b8@192.168.1.11' of Request 102: Match Found
Jun 11 13:48:28 VERBOSE[2180] logger.c: Destroying call '6a867137361ce8b2774bbd4d271f31b8@192.168.1.11'
Jun 11 13:48:28 DEBUG[2180] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
Jun 11 13:48:28 DEBUG[2180] acl.c: ##### Testing 212.27.52.5 with 192.168.1.0
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Target address 212.27.52.5 is not local, substituting externip
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 0: OPTIONS sip:freephonie.net SIP/2.0 (34)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 1: Via: SIP/2.0/UDP 87.90.132.119:5060;branch=z9hG4bK32fc4acf;rport (64)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 2: From: "Unknown" ;tag=as08297385 (58)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 3: To: (24)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 4: Contact: (36)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 5: Call-ID: 16f2f61423c71428259458ce274bb4e8@87.90.132.119 (55)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 6: CSeq: 102 OPTIONS (17)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 7: User-Agent: Asterisk PBX (24)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 9: Date: Sun, 11 Jun 2006 11:48:31 GMT (35)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 10: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY (66)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 12: (0)
Jun 11 13:48:31 VERBOSE[2180] logger.c: 12 headers, 0 lines
Jun 11 13:48:31 VERBOSE[2180] logger.c: Reliably Transmitting (NAT) to 212.27.52.5:5060:
OPTIONS sip:freephonie.net SIP/2.0
Via: SIP/2.0/UDP 87.90.132.119:5060;branch=z9hG4bK32fc4acf;rport
From: "Unknown" ;tag=as08297385
To:
Contact:
Call-ID: 16f2f61423c71428259458ce274bb4e8@87.90.132.119
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Sun, 11 Jun 2006 11:48:31 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #947
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Auto destroying call '01-01753-012b3615-34b3404f3@freephonie.net'
Jun 11 13:48:31 VERBOSE[2180] logger.c: Destroying call '01-01753-012b3615-34b3404f3@freephonie.net'
Jun 11 13:48:31 VERBOSE[2180] logger.c:
<-- SIP read from 212.27.52.5:5060:
SIP/2.0 501 not implemented yet
Call-ID: 16f2f61423c71428259458ce274bb4e8@87.90.132.119
CSeq: 102 OPTIONS
From: "Unknown" ;tag=as08297385
To: ;tag=01-08155-012b3740-6b1cd8d92
Via: SIP/2.0/UDP 87.90.132.119:5060;received=87.90.132.119;rport=5060;branch=z9hG4bK32fc4acf
Content-Length: 0
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 0: SIP/2.0 501 not implemented yet (31)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 1: Call-ID: 16f2f61423c71428259458ce274bb4e8@87.90.132.119 (55)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 2: CSeq: 102 OPTIONS (17)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 3: From: "Unknown" ;tag=as08297385 (58)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 4: To: ;tag=01-08155-012b3740-6b1cd8d92 (56)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 5: Via: SIP/2.0/UDP 87.90.132.119:5060;received=87.90.132.119;rport=5060;branch=z9hG4bK32fc4acf (92)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 6: Content-Length: 0 (17)
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 7: (0)
Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (7 headers 0 lines)Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (7 headers 0 lines)---
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #947
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Stopping retransmission on '16f2f61423c71428259458ce274bb4e8@87.90.132.119' of Request 102: Match Found
Jun 11 13:48:31 VERBOSE[2180] logger.c: Destroying call '16f2f61423c71428259458ce274bb4e8@87.90.132.119'
Jun 11 13:48:31 DEBUG[3475] manager.c: Manager received command 'Command'
Jun 11 13:48:31 DEBUG[3475] manager.c: Manager received command 'Command'
Jun 11 13:48:31 VERBOSE[2180] logger.c:
<-- SIP read from 192.168.1.43:5061:
Jun 11 13:48:31 DEBUG[2180] chan_sip.c: Header 0: (0)
Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines)Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines) Nat keepalive Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines) Nat keepalive ---
Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines)Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines) Nat keepalive Jun 11 13:48:31 VERBOSE[2180] logger.c: --- (0 headers 0 lines) Nat keepalive ---