rendered paste bodyJun 8 11:24:49 VERBOSE[2736] logger.c: Asterisk Event Logger restarted
Jun 8 11:24:49 VERBOSE[2736] logger.c: Asterisk Queue Logger restarted
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bK2eea3aab825BD2A6 (61)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 2: From: "Jim" <sip:502@192.168.3.1>;tag=1239705-34190662 (54)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 3: To: <sip:502@192.168.3.1> (25)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 5: Call-ID: f6471ba9-b675c5c7-800a1274@192.168.3.207 (49)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for f6471ba9-b675c5c7-800a1274@192.168.3.207 - REGISTER (No RTP)
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:24:52 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:24:52 NOTICE[2693] chan_sip.c: Registration from '<sip:502@192.168.3.1>' failed for '192.168.3.207' - Username/auth name mismatch
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:24:53 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:24:53 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:24:53 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1118
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK232d9b2a;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as52b1f4e0 (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:24:53 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK232d9b2a;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as52b1f4e0
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 165 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1119
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1120
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5a4e32b8;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as69147ccd (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:24:53 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5a4e32b8;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as69147ccd
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 165 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1121
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1122
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1f83d194;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4e20a20d (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:24:53 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1f83d194;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4e20a20d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 165 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1123
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:24:53 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:24:53 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK232d9b2a;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as52b1f4e0
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 165 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK232d9b2a;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as52b1f4e0 (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1119
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 165: Match Found
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Cancelling timeout 1118
Jun 8 11:24:53 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:24:53 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5a4e32b8;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as69147ccd
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 165 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5a4e32b8;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as69147ccd (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1121
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 165: Match Found
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Cancelling timeout 1120
Jun 8 11:24:53 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:24:53 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1f83d194;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4e20a20d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 165 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1f83d194;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4e20a20d (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1123
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 165: Match Found
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Cancelling timeout 1122
Jun 8 11:24:53 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1130
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK762925df;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as14f01972 (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:24:53 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:24:53 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK762925df;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as14f01972
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 165 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1131
Jun 8 11:24:53 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK762925df;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as14f01972
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 165 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK762925df;rport (63)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as14f01972 (61)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 5: CSeq: 165 REGISTER (18)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:24:53 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1131
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 165: Match Found
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Cancelling timeout 1130
Jun 8 11:24:53 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:24:53 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKfb29410bBFF6D180 (61)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=869AFD15-B05DB93C (58)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 27870e9-e21bf117-9e184396@192.168.3.114 (48)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 27870e9-e21bf117-9e184396@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:24:55 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:24:55 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:24:56 DEBUG[2693] chan_sip.c: Auto destroying call 'c8179b94-4d6e105a-55d4b5ff@192.168.3.112'
Jun 8 11:24:57 DEBUG[2693] chan_sip.c: Auto destroying call '2a21cccb-e02e275d-b1cbe82a@192.168.3.202'
Jun 8 11:25:07 DEBUG[2693] chan_sip.c: Auto destroying call 'f6471ba9-b675c5c7-800a1274@192.168.3.207'
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:09 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:09 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:09 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1135
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK61a26c4f;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as2a0b6554 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:09 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK61a26c4f;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as2a0b6554
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 166 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1136
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1137
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07e2ca37;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as21c96106 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:09 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07e2ca37;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as21c96106
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 166 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1138
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1139
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK00d268db;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as671dd4b3 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:09 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK00d268db;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as671dd4b3
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 166 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1140
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:09 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:09 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK61a26c4f;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as2a0b6554
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 166 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK61a26c4f;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as2a0b6554 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1136
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 166: Match Found
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Cancelling timeout 1135
Jun 8 11:25:09 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:09 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07e2ca37;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as21c96106
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 166 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07e2ca37;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as21c96106 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1138
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 166: Match Found
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Cancelling timeout 1137
Jun 8 11:25:09 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:09 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK00d268db;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as671dd4b3
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 166 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK00d268db;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as671dd4b3 (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1140
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 166: Match Found
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Cancelling timeout 1139
Jun 8 11:25:09 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1147
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0aff66fe;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as673911af (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:09 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:09 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0aff66fe;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as673911af
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 166 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1148
Jun 8 11:25:09 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0aff66fe;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as673911af
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 166 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0aff66fe;rport (63)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as673911af (61)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 5: CSeq: 166 REGISTER (18)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:09 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1148
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 166: Match Found
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Cancelling timeout 1147
Jun 8 11:25:09 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:25:09 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:10 DEBUG[2693] chan_sip.c: Auto destroying call '27870e9-e21bf117-9e184396@192.168.3.114'
Jun 8 11:25:15 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
INVITE sip:17653820296@24.123.18.101:5060 SIP/2.0
Via: SIP/2.0/UDP 216.115.20.41:5061
Via: SIP/2.0/UDP 69.59.242.97:5060
Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bK1DBE
Record-Route: <sip:17653820296@216.115.20.41:5061>
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=1560376310
To: <sip:17653820296@inbound4.vonage.net>
Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17
CSeq: 101 INVITE
Contact: <sip:17652436199@208.48.204.17:5060>
Max-Forwards: 14
Content-Type: application/sdp
Content-Length: 360
v=0
o=CiscoSystemsSIP-GW-UserAgent 8441 105 IN IP4 208.48.204.22
s=SIP Call
c=IN IP4 208.48.204.22
t=0 0
m=audio 13798 RTP/AVP 0 18 2 100 101
c=IN IP4 208.48.204.22
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:2 G726-32/8000
a=rtpmap:100 X-NSE/8000
a=fmtp:100 192-194
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 0: INVITE sip:17653820296@24.123.18.101:5060 SIP/2.0 (49)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 216.115.20.41:5061 (35)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 2: Via: SIP/2.0/UDP 69.59.242.97:5060 (34)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 3: Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bK1DBE (54)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 4: Record-Route: <sip:17653820296@216.115.20.41:5061> (50)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 5: From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=1560376310 (70)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 6: To: <sip:17653820296@inbound4.vonage.net> (41)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 7: Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17 (58)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 8: CSeq: 101 INVITE (16)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:17652436199@208.48.204.17:5060> (45)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 10: Max-Forwards: 14 (16)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 11: Content-Type: application/sdp (29)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 12: Content-Length: 360 (21)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 13: (0)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: v=0 (3)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: o=CiscoSystemsSIP-GW-UserAgent 8441 105 IN IP4 208.48.204.22 (60)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: s=SIP Call (10)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: c=IN IP4 208.48.204.22 (22)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: t=0 0 (5)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: m=audio 13798 RTP/AVP 0 18 2 100 101 (36)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: c=IN IP4 208.48.204.22 (22)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=rtpmap:18 G729/8000 (21)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=fmtp:18 annexb=no (19)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=rtpmap:2 G726-32/8000 (23)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=rtpmap:100 X-NSE/8000 (23)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=fmtp:100 192-194 (18)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Line: a=fmtp:101 0-16 (15)
Jun 8 11:25:15 VERBOSE[2693] logger.c: --- (13 headers 15 lines)Jun 8 11:25:15 VERBOSE[2693] logger.c: --- (13 headers 15 lines)---
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17 - INVITE (With RTP)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jun 8 11:25:15 VERBOSE[2693] logger.c: Using INVITE request as basis request - D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17
Jun 8 11:25:15 VERBOSE[2693] logger.c: Sending to 216.115.20.41 : 5061 (non-NAT)
Jun 8 11:25:15 VERBOSE[2693] logger.c: Found peer 'VON'
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Setting NAT on RTP to 524288
Jun 8 11:25:15 VERBOSE[2693] logger.c: Reliably Transmitting (NAT) to 216.115.20.41:5061:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 216.115.20.41:5061;received=216.115.20.41
Via: SIP/2.0/UDP 69.59.242.97:5060
Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bK1DBE
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=1560376310
To: <sip:17653820296@inbound4.vonage.net>;tag=as1b159e41
Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17
CSeq: 101 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:17653820296@192.168.1.12>
Proxy-Authenticate: Digest realm="asterisk", nonce="7a9a7df9"
Content-Length: 0
---
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1151
Jun 8 11:25:15 VERBOSE[2693] logger.c: Scheduling destruction of call 'D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17' in 15000 ms
Jun 8 11:25:15 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
ACK sip:17653820296@24.123.18.101:5060 SIP/2.0
Via: SIP/2.0/UDP 216.115.20.41:5061
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=1560376310
To: <sip:17653820296@inbound4.vonage.net>;tag=as1b159e41
Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17
CSeq: 101 ACK
Content-Length: 0
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 0: ACK sip:17653820296@24.123.18.101:5060 SIP/2.0 (46)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 216.115.20.41:5061 (35)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 2: From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=1560376310 (70)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@inbound4.vonage.net>;tag=as1b159e41 (56)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 4: Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17 (58)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 5: CSeq: 101 ACK (13)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 6: Content-Length: 0 (17)
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 7: (0)
Jun 8 11:25:15 VERBOSE[2693] logger.c: --- (7 headers 0 lines)Jun 8 11:25:15 VERBOSE[2693] logger.c: --- (7 headers 0 lines)---
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1151
Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Stopping retransmission on 'D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17' of Response 101: Match Found
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bKe8556ad84452F6F3 (61)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 2: From: "Kelly" <sip:500@192.168.3.1>;tag=8BD04116-3056EAE7 (57)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 3: To: <sip:500@192.168.3.1> (25)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 3a1f6532-d4b6091c-832ba5c5@192.168.3.202 (49)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041 (54)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 3a1f6532-d4b6091c-832ba5c5@192.168.3.202 - REGISTER (No RTP)
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:25:23 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:25:23 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:25 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:25 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:25 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1154
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK341758c5;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4314a09e (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:25 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK341758c5;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4314a09e
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 167 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1155
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1156
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19195b84;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as45c4d4cb (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:25 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19195b84;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as45c4d4cb
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 167 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1157
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1158
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK65815779;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as65aa383e (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:25 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK65815779;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as65aa383e
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 167 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1159
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:25 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:25 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK341758c5;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4314a09e
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 167 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK341758c5;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4314a09e (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1155
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 167: Match Found
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Cancelling timeout 1154
Jun 8 11:25:25 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:25 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19195b84;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as45c4d4cb
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 167 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19195b84;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as45c4d4cb (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1157
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 167: Match Found
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Cancelling timeout 1156
Jun 8 11:25:25 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:25 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK65815779;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as65aa383e
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 167 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK65815779;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as65aa383e (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1159
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 167: Match Found
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Cancelling timeout 1158
Jun 8 11:25:25 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1166
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5916235c;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0057d56b (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:25 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:25 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5916235c;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0057d56b
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 167 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1167
Jun 8 11:25:25 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5916235c;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0057d56b
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 167 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5916235c;rport (63)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0057d56b (61)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 5: CSeq: 167 REGISTER (18)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:25 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1167
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 167: Match Found
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Cancelling timeout 1166
Jun 8 11:25:25 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:25:25 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:30 DEBUG[2693] chan_sip.c: Auto destroying call 'D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17'
Jun 8 11:25:30 VERBOSE[2693] logger.c: Destroying call 'D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17'
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK23470c314C6B52C (60)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 2: From: "Ben" <sip:503@192.168.3.1>;tag=39271823-27587878 (55)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 3: To: <sip:503@192.168.3.1> (25)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 4907a317-907709bd-5f4f28f2@192.168.3.112 (49)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 4907a317-907709bd-5f4f28f2@192.168.3.112 - REGISTER (No RTP)
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:25:36 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:25:36 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:25:38 DEBUG[2693] chan_sip.c: Auto destroying call '3a1f6532-d4b6091c-832ba5c5@192.168.3.202'
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:41 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:41 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:41 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1171
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6117c77a;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6e2ca8fc (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:41 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6117c77a;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6e2ca8fc
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 168 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1172
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1173
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0ebc6164;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as1a950962 (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:41 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0ebc6164;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as1a950962
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 168 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1174
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1175
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7dbacb0f;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4ec7765e (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:41 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7dbacb0f;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4ec7765e
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 168 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1176
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:41 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1177
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK42d97ae8;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3fd96f30 (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:41 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:41 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK42d97ae8;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3fd96f30
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 168 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1178
Jun 8 11:25:41 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6117c77a;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6e2ca8fc
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 168 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6117c77a;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6e2ca8fc (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1172
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 168: Match Found
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Cancelling timeout 1171
Jun 8 11:25:41 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:41 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0ebc6164;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as1a950962
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 168 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0ebc6164;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as1a950962 (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1174
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 168: Match Found
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Cancelling timeout 1173
Jun 8 11:25:41 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:41 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7dbacb0f;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4ec7765e
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 168 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7dbacb0f;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4ec7765e (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1176
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 168: Match Found
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Cancelling timeout 1175
Jun 8 11:25:41 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:41 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK42d97ae8;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3fd96f30
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 168 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK42d97ae8;rport (63)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3fd96f30 (61)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 5: CSeq: 168 REGISTER (18)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:41 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1178
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 168: Match Found
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Cancelling timeout 1177
Jun 8 11:25:41 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:25:41 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKcb33d9386709CA81 (61)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=5BDA236A-F83C852D (58)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 2b8be28e-d8466d74-3905c6ef@192.168.3.114 (49)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 2b8be28e-d8466d74-3905c6ef@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:25:42 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:25:42 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKf21be29e1C0FC6E1 (61)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 2: From: "Jim" <sip:502@192.168.3.1>;tag=CF3801E8-8311B3D (54)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 3: To: <sip:502@192.168.3.1> (25)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 5: Call-ID: f7f286ec-52b575a-6360817f@192.168.3.207 (48)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for f7f286ec-52b575a-6360817f@192.168.3.207 - REGISTER (No RTP)
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:25:44 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:25:44 NOTICE[2693] chan_sip.c: Registration from '<sip:502@192.168.3.1>' failed for '192.168.3.207' - Username/auth name mismatch
Jun 8 11:25:51 DEBUG[2693] chan_sip.c: Auto destroying call '4907a317-907709bd-5f4f28f2@192.168.3.112'
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:57 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:57 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:57 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:57 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1189
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK79cb7ba9;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as55171ac1 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:25:57 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK79cb7ba9;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as55171ac1
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 169 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1190
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1191
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK34c34c57;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as5adb644f (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:25:57 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK34c34c57;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as5adb644f
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 169 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1192
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1193
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1ee3d669;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4907e3f5 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:25:57 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1ee3d669;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4907e3f5
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 169 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1194
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1195
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK171d7c81;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as64452787 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:25:57 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:25:57 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK171d7c81;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as64452787
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 169 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1196
Jun 8 11:25:57 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK79cb7ba9;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as55171ac1
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 169 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK79cb7ba9;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as55171ac1 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1190
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 169: Match Found
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Cancelling timeout 1189
Jun 8 11:25:57 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:57 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK34c34c57;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as5adb644f
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 169 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK34c34c57;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as5adb644f (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1192
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 169: Match Found
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Cancelling timeout 1191
Jun 8 11:25:57 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:57 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1ee3d669;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4907e3f5
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 169 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1ee3d669;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as4907e3f5 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1194
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 169: Match Found
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Cancelling timeout 1193
Jun 8 11:25:57 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:57 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK171d7c81;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as64452787
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 169 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK171d7c81;rport (63)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as64452787 (61)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 5: CSeq: 169 REGISTER (18)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:25:57 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1196
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 169: Match Found
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Cancelling timeout 1195
Jun 8 11:25:57 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:25:57 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Auto destroying call '2b8be28e-d8466d74-3905c6ef@192.168.3.114'
Jun 8 11:25:59 DEBUG[2693] chan_sip.c: Auto destroying call 'f7f286ec-52b575a-6360817f@192.168.3.207'
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bKf53e4e1b8B834B3A (61)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 2: From: "Kelly" <sip:500@192.168.3.1>;tag=194748C1-E6E2679E (57)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 3: To: <sip:500@192.168.3.1> (25)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 5a80192d-4ac3148f-4b20664@192.168.3.202 (48)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041 (54)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 5a80192d-4ac3148f-4b20664@192.168.3.202 - REGISTER (No RTP)
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:26:12 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:26:12 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:26:13 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:26:13 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:26:13 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:26:13 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1206
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2ce3c925;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6d9cf2aa (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:26:13 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2ce3c925;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6d9cf2aa
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 170 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1207
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1208
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1b052496;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as67492777 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:26:13 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1b052496;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as67492777
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 170 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1209
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1210
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6874eff7;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as494a9346 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:26:13 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6874eff7;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as494a9346
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 170 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1211
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1212
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19487dca;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as5b841df3 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:13 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:26:13 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19487dca;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as5b841df3
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 170 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1213
Jun 8 11:26:13 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2ce3c925;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6d9cf2aa
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 170 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2ce3c925;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as6d9cf2aa (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1207
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 170: Match Found
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Cancelling timeout 1206
Jun 8 11:26:13 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:13 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1b052496;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as67492777
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 170 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1b052496;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as67492777 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1209
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 170: Match Found
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Cancelling timeout 1208
Jun 8 11:26:13 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:13 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6874eff7;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as494a9346
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 170 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK6874eff7;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as494a9346 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1211
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 170: Match Found
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Cancelling timeout 1210
Jun 8 11:26:13 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:13 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19487dca;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as5b841df3
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 170 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK19487dca;rport (63)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as5b841df3 (61)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 5: CSeq: 170 REGISTER (18)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:13 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1213
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 170: Match Found
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Cancelling timeout 1212
Jun 8 11:26:13 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:26:13 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK492a0ac46B38C2F (60)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 2: From: "Ben" <sip:503@192.168.3.1>;tag=430FEE56-D007BF3B (55)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 3: To: <sip:503@192.168.3.1> (25)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 5e89fd8a-215a2c10-a9f6a1d5@192.168.3.112 (49)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 5e89fd8a-215a2c10-a9f6a1d5@192.168.3.112 - REGISTER (No RTP)
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:26:15 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:26:15 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKceb41919D5996A86 (61)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=6C71A213-C32413E2 (58)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 5: Call-ID: d536c9c7-5226b245-b1f322ac@192.168.3.114 (49)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for d536c9c7-5226b245-b1f322ac@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:26:18 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:26:18 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:26:27 DEBUG[2693] chan_sip.c: Auto destroying call '5a80192d-4ac3148f-4b20664@192.168.3.202'
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:26:29 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:26:29 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:26:29 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:26:29 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1224
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK3f4b2070;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as5ace8788 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:26:29 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK3f4b2070;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as5ace8788
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 171 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1225
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1226
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7e3551b1;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as4adfdb48 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:26:29 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7e3551b1;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as4adfdb48
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 171 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1227
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1228
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07909db6;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as67760e55 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:26:29 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07909db6;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as67760e55
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 171 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1229
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #1230
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2458f289;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as67c7e9b0 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:26:29 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:26:29 VERBOSE[2693] logger.c: Reliably Transmitting (no NAT) to 216.115.20.41:5061:
REGISTER sip:sphone.vopr.vonage.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2458f289;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as67c7e9b0
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 171 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #1231
Jun 8 11:26:29 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK3f4b2070;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as5ace8788
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 171 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK3f4b2070;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as5ace8788 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1225
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 171: Match Found
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Cancelling timeout 1224
Jun 8 11:26:29 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:29 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7e3551b1;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as4adfdb48
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 171 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7e3551b1;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as4adfdb48 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1227
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 171: Match Found
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Cancelling timeout 1226
Jun 8 11:26:29 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:29 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07909db6;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as67760e55
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 171 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK07909db6;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as67760e55 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1229
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 171: Match Found
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Cancelling timeout 1228
Jun 8 11:26:29 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:29 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2458f289;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as67c7e9b0
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 171 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK2458f289;rport (63)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as67c7e9b0 (61)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 5: CSeq: 171 REGISTER (18)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:26:29 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #1231
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 171: Match Found
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Cancelling timeout 1230
Jun 8 11:26:29 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:26:29 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:26:30 DEBUG[2693] chan_sip.c: Auto destroying call '5e89fd8a-215a2c10-a9f6a1d5@192.168.3.112'