Jun 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" ;tag=1239705-34190662 (54) Jun 8 11:24:52 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as52b1f4e0 (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as52b1f4e0 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 165 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as69147ccd (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as69147ccd To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 165 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as4e20a20d (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as4e20a20d To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 165 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as52b1f4e0 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 165 REGISTER Contact: ;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: ;tag=as52b1f4e0 (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as69147ccd To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 165 REGISTER Contact: ;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: ;tag=as69147ccd (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as4e20a20d To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 165 REGISTER Contact: ;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: ;tag=as4e20a20d (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as14f01972 (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as14f01972 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 165 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as14f01972 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 165 REGISTER Contact: ;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: ;tag=as14f01972 (61) Jun 8 11:24:53 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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" ;tag=869AFD15-B05DB93C (58) Jun 8 11:24:55 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as2a0b6554 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as2a0b6554 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 166 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as21c96106 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as21c96106 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 166 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as671dd4b3 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as671dd4b3 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 166 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as2a0b6554 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 166 REGISTER Contact: ;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: ;tag=as2a0b6554 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as21c96106 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 166 REGISTER Contact: ;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: ;tag=as21c96106 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as671dd4b3 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 166 REGISTER Contact: ;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: ;tag=as671dd4b3 (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as673911af (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as673911af To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 166 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as673911af To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 166 REGISTER Contact: ;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: ;tag=as673911af (61) Jun 8 11:25:09 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: From: "LOWMILLER HEATH" ;tag=1560376310 To: Call-ID: D196E29C-F63911DA-BD56ADA4-BC992F66@208.48.204.17 CSeq: 101 INVITE Contact: 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: (50) Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 5: From: "LOWMILLER HEATH" ;tag=1560376310 (70) Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 6: To: (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: (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" ;tag=1560376310 To: ;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: 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" ;tag=1560376310 To: ;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" ;tag=1560376310 (70) Jun 8 11:25:15 DEBUG[2693] chan_sip.c: Header 3: To: ;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" ;tag=8BD04116-3056EAE7 (57) Jun 8 11:25:23 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as4314a09e (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as4314a09e To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 167 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as45c4d4cb (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as45c4d4cb To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 167 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as65aa383e (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as65aa383e To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 167 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as4314a09e To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 167 REGISTER Contact: ;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: ;tag=as4314a09e (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as45c4d4cb To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 167 REGISTER Contact: ;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: ;tag=as45c4d4cb (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as65aa383e To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 167 REGISTER Contact: ;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: ;tag=as65aa383e (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as0057d56b (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as0057d56b To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 167 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as0057d56b To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 167 REGISTER Contact: ;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: ;tag=as0057d56b (61) Jun 8 11:25:25 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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" ;tag=39271823-27587878 (55) Jun 8 11:25:36 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as6e2ca8fc (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as6e2ca8fc To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 168 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as1a950962 (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as1a950962 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 168 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as4ec7765e (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as4ec7765e To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 168 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as3fd96f30 (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as3fd96f30 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 168 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as6e2ca8fc To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 168 REGISTER Contact: ;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: ;tag=as6e2ca8fc (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as1a950962 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 168 REGISTER Contact: ;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: ;tag=as1a950962 (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as4ec7765e To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 168 REGISTER Contact: ;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: ;tag=as4ec7765e (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as3fd96f30 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 168 REGISTER Contact: ;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: ;tag=as3fd96f30 (61) Jun 8 11:25:41 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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" ;tag=5BDA236A-F83C852D (58) Jun 8 11:25:42 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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" ;tag=CF3801E8-8311B3D (54) Jun 8 11:25:44 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as55171ac1 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as55171ac1 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 169 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as5adb644f (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as5adb644f To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 169 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as4907e3f5 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as4907e3f5 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 169 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as64452787 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as64452787 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 169 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as55171ac1 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 169 REGISTER Contact: ;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: ;tag=as55171ac1 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as5adb644f To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 169 REGISTER Contact: ;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: ;tag=as5adb644f (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as4907e3f5 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 169 REGISTER Contact: ;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: ;tag=as4907e3f5 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as64452787 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 169 REGISTER Contact: ;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: ;tag=as64452787 (61) Jun 8 11:25:57 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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" ;tag=194748C1-E6E2679E (57) Jun 8 11:26:12 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as6d9cf2aa (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as6d9cf2aa To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 170 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as67492777 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as67492777 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 170 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as494a9346 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as494a9346 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 170 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as5b841df3 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as5b841df3 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 170 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as6d9cf2aa To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 170 REGISTER Contact: ;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: ;tag=as6d9cf2aa (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as67492777 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 170 REGISTER Contact: ;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: ;tag=as67492777 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as494a9346 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 170 REGISTER Contact: ;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: ;tag=as494a9346 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as5b841df3 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 170 REGISTER Contact: ;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: ;tag=as5b841df3 (61) Jun 8 11:26:13 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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" ;tag=430FEE56-D007BF3B (55) Jun 8 11:26:15 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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" ;tag=6C71A213-C32413E2 (58) Jun 8 11:26:18 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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 '' 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: ;tag=as5ace8788 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as5ace8788 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 171 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as4adfdb48 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as4adfdb48 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 171 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as67760e55 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as67760e55 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 171 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as67c7e9b0 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: (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: ;tag=as67c7e9b0 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 171 REGISTER User-Agent: Asterisk PBX Max-Forwards: 70 Expires: 120 Contact: 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: ;tag=as5ace8788 To: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 CSeq: 171 REGISTER Contact: ;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: ;tag=as5ace8788 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as4adfdb48 To: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 CSeq: 171 REGISTER Contact: ;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: ;tag=as4adfdb48 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as67760e55 To: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 CSeq: 171 REGISTER Contact: ;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: ;tag=as67760e55 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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: ;tag=as67c7e9b0 To: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 CSeq: 171 REGISTER Contact: ;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: ;tag=as67c7e9b0 (61) Jun 8 11:26:29 DEBUG[2693] chan_sip.c: Header 3: To: (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: ;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'