rendered paste bodyJun 8 11:13:23 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:13:23 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:13:25 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #376
Jun 8 11:13:38 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #378
Jun 8 11:13:38 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 123: Match Found
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Cancelling timeout 376
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 123: Match Found
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Cancelling timeout 378
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #384
Jun 8 11:13:38 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '86444b39-b7fa76e7-6dd03926@192.168.3.114'
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 123: Match Found
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Cancelling timeout 384
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for f6b487c-cc9277ea-ff37f08f@192.168.3.207 - REGISTER (No RTP)
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:13:38 NOTICE[2693] chan_sip.c: Registration from '<sip:502@192.168.3.1>' failed for '192.168.3.207' - Username/auth name mismatch
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #389
Jun 8 11:13:38 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 123: Match Found
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Cancelling timeout 389
Jun 8 11:13:38 DEBUG[2693] chan_sip.c: Auto destroying call '468c3ba2-1787f50c-cb48f75@192.168.3.202'
Jun 8 11:13:40 DEBUG[2693] chan_sip.c: Auto destroying call 'b3b3e2e4-3612e9aa-6c185e4f@192.168.3.112'
Jun 8 11:13:53 DEBUG[2693] chan_sip.c: Auto destroying call 'f6b487c-cc9277ea-ff37f08f@192.168.3.207'
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:13:54 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:13:54 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #393
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1078ef11;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as48136a7c (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:13:54 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=z9hG4bK1078ef11;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as48136a7c
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 124 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #394
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #395
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7968c0ae;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as63bd971d (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:13:54 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=z9hG4bK7968c0ae;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as63bd971d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 124 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #396
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:13:54 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:13:54 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=z9hG4bK1078ef11;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as48136a7c
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 124 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1078ef11;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as48136a7c (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #394
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 124: Match Found
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Cancelling timeout 393
Jun 8 11:13:54 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:13:54 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=z9hG4bK7968c0ae;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as63bd971d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 124 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK7968c0ae;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as63bd971d (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #396
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 124: Match Found
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Cancelling timeout 395
Jun 8 11:13:54 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #401
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK609d88d2;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as090f8292 (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:13:54 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=z9hG4bK609d88d2;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as090f8292
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 124 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #402
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:13:54 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:13:54 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=z9hG4bK609d88d2;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as090f8292
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 124 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK609d88d2;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as090f8292 (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #402
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 124: Match Found
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Cancelling timeout 401
Jun 8 11:13:54 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #405
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK59e0ec87;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as21ca6b01 (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:13:54 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:13:54 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=z9hG4bK59e0ec87;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as21ca6b01
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 124 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #406
Jun 8 11:13:54 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=z9hG4bK59e0ec87;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as21ca6b01
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 124 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK59e0ec87;rport (63)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as21ca6b01 (61)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 5: CSeq: 124 REGISTER (18)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:13:54 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #406
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 124: Match Found
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:13:54 DEBUG[2693] chan_sip.c: Cancelling timeout 405
Jun 8 11:13:54 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:13:54 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK90800a81E6C8C47C (61)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 2: From: "Ben" <sip:503@192.168.3.1>;tag=369EAC73-8FA0EBC8 (55)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 3: To: <sip:503@192.168.3.1> (25)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 687b9367-e87d2c0d-43f6ca42@192.168.3.112 (49)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 687b9367-e87d2c0d-43f6ca42@192.168.3.112 - REGISTER (No RTP)
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:00 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:00 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKe525974889408AD1 (61)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=DD3DCDFA-CA66307D (58)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 9162161e-2a9c7a84-9b7a42bf@192.168.3.114 (49)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 9162161e-2a9c7a84-9b7a42bf@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:06 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:06 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:10 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:10 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #411
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5fc9b6c5;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as15e659e1 (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:10 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=z9hG4bK5fc9b6c5;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as15e659e1
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 125 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #412
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #413
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK40e78754;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as460d9f1d (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:10 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=z9hG4bK40e78754;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as460d9f1d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 125 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #414
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:10 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:10 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=z9hG4bK5fc9b6c5;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as15e659e1
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 125 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5fc9b6c5;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as15e659e1 (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #412
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 125: Match Found
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Cancelling timeout 411
Jun 8 11:14:10 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:10 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=z9hG4bK40e78754;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as460d9f1d
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 125 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK40e78754;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as460d9f1d (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #414
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 125: Match Found
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Cancelling timeout 413
Jun 8 11:14:10 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #419
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK20842672;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as06a3064e (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:10 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=z9hG4bK20842672;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as06a3064e
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 125 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #420
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:10 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:10 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=z9hG4bK20842672;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as06a3064e
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 125 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK20842672;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as06a3064e (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #420
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 125: Match Found
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Cancelling timeout 419
Jun 8 11:14:10 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #423
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK25a72eb4;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as45968313 (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:10 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:10 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=z9hG4bK25a72eb4;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as45968313
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 125 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #424
Jun 8 11:14:10 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=z9hG4bK25a72eb4;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as45968313
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 125 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK25a72eb4;rport (63)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as45968313 (61)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 5: CSeq: 125 REGISTER (18)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:10 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #424
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 125: Match Found
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:10 DEBUG[2693] chan_sip.c: Cancelling timeout 423
Jun 8 11:14:10 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:14:10 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:15 DEBUG[2693] chan_sip.c: Auto destroying call '687b9367-e87d2c0d-43f6ca42@192.168.3.112'
Jun 8 11:14:15 VERBOSE[2693] logger.c: Destroying call '687b9367-e87d2c0d-43f6ca42@192.168.3.112'
Jun 8 11:14:18 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.202:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bKee69124b8E55DFAA
From: "Kelly" <sip:500@192.168.3.1>;tag=C227D371-F6FC830E
To: <sip:500@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: 24a68dd-9db95bbf-cf35e054@192.168.3.202
Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bKee69124b8E55DFAA (61)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 2: From: "Kelly" <sip:500@192.168.3.1>;tag=C227D371-F6FC830E (57)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 3: To: <sip:500@192.168.3.1> (25)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 24a68dd-9db95bbf-cf35e054@192.168.3.202 (48)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041 (54)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:18 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:14:18 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 24a68dd-9db95bbf-cf35e054@192.168.3.202 - REGISTER (No RTP)
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:18 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:14:18 VERBOSE[2693] logger.c: Sending to 192.168.3.202 : 5060 (non-NAT)
Jun 8 11:14:18 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.202:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bKee69124b8E55DFAA;received=192.168.3.202
From: "Kelly" <sip:500@192.168.3.1>;tag=C227D371-F6FC830E
To: <sip:500@192.168.3.1>;tag=as3369bf10
Call-ID: 24a68dd-9db95bbf-cf35e054@192.168.3.202
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:500@192.168.3.1>
Content-Length: 0
---
Jun 8 11:14:18 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:18 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:14:18 VERBOSE[2693] logger.c: Scheduling destruction of call '24a68dd-9db95bbf-cf35e054@192.168.3.202' in 15000 ms
Jun 8 11:14:21 DEBUG[2693] chan_sip.c: Auto destroying call '9162161e-2a9c7a84-9b7a42bf@192.168.3.114'
Jun 8 11:14:21 VERBOSE[2693] logger.c: Destroying call '9162161e-2a9c7a84-9b7a42bf@192.168.3.114'
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:26 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:26 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #428
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4c8a3be7;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as035754c2 (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:26 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=z9hG4bK4c8a3be7;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as035754c2
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 126 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #429
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #430
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK47e19bf1;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1cc64d1a (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:26 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=z9hG4bK47e19bf1;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1cc64d1a
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 126 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #431
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:26 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #432
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1723c0cd;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as3eaf6a6e (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:26 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=z9hG4bK1723c0cd;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as3eaf6a6e
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 126 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #433
Jun 8 11:14:26 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=z9hG4bK4c8a3be7;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as035754c2
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 126 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4c8a3be7;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as035754c2 (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #429
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 126: Match Found
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Cancelling timeout 428
Jun 8 11:14:26 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:26 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=z9hG4bK47e19bf1;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1cc64d1a
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 126 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK47e19bf1;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1cc64d1a (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #431
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 126: Match Found
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Cancelling timeout 430
Jun 8 11:14:26 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:26 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:26 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=z9hG4bK1723c0cd;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as3eaf6a6e
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 126 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK1723c0cd;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as3eaf6a6e (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #433
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 126: Match Found
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Cancelling timeout 432
Jun 8 11:14:26 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #440
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4261a6bf;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3c42486a (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:26 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:26 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=z9hG4bK4261a6bf;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3c42486a
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 126 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #441
Jun 8 11:14:26 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=z9hG4bK4261a6bf;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3c42486a
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 126 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4261a6bf;rport (63)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as3c42486a (61)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 5: CSeq: 126 REGISTER (18)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:26 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #441
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 126: Match Found
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:26 DEBUG[2693] chan_sip.c: Cancelling timeout 440
Jun 8 11:14:26 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:14:26 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:27 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 216.115.30.26:5060
Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bKCE8
Record-Route: <sip:17653820296@216.115.20.41:5061>
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=2143609300
To: <sip:17653820296@inbound4.vonage.net>
Call-ID: 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17
CSeq: 101 INVITE
Contact: <sip:17652436199@208.48.204.17:5060>
Max-Forwards: 14
Content-Type: application/sdp
Content-Length: 361
v=0
o=CiscoSystemsSIP-GW-UserAgent 7774 4427 IN IP4 208.48.204.20
s=SIP Call
c=IN IP4 208.48.204.20
t=0 0
m=audio 13600 RTP/AVP 0 18 2 100 101
c=IN IP4 208.48.204.20
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:14:27 DEBUG[2693] chan_sip.c: Header 0: INVITE sip:17653820296@24.123.18.101:5060 SIP/2.0 (49)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 216.115.20.41:5061 (35)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 2: Via: SIP/2.0/UDP 216.115.30.26:5060 (35)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 3: Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bKCE8 (53)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 4: Record-Route: <sip:17653820296@216.115.20.41:5061> (50)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 5: From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=2143609300 (70)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 6: To: <sip:17653820296@inbound4.vonage.net> (41)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 7: Call-ID: 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17 (58)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 8: CSeq: 101 INVITE (16)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:17652436199@208.48.204.17:5060> (45)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 10: Max-Forwards: 14 (16)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 11: Content-Type: application/sdp (29)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 12: Content-Length: 361 (21)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 13: (0)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: v=0 (3)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: o=CiscoSystemsSIP-GW-UserAgent 7774 4427 IN IP4 208.48.204.20 (61)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: s=SIP Call (10)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: c=IN IP4 208.48.204.20 (22)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: t=0 0 (5)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: m=audio 13600 RTP/AVP 0 18 2 100 101 (36)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: c=IN IP4 208.48.204.20 (22)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=rtpmap:0 PCMU/8000 (20)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=rtpmap:18 G729/8000 (21)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=fmtp:18 annexb=no (19)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=rtpmap:2 G726-32/8000 (23)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=rtpmap:100 X-NSE/8000 (23)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=fmtp:100 192-194 (18)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=rtpmap:101 telephone-event/8000 (33)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Line: a=fmtp:101 0-16 (15)
Jun 8 11:14:27 VERBOSE[2693] logger.c: --- (13 headers 15 lines)Jun 8 11:14:27 VERBOSE[2693] logger.c: --- (13 headers 15 lines)---
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17 - INVITE (With RTP)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
Jun 8 11:14:27 VERBOSE[2693] logger.c: Using INVITE request as basis request - 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17
Jun 8 11:14:27 VERBOSE[2693] logger.c: Sending to 216.115.20.41 : 5061 (non-NAT)
Jun 8 11:14:27 VERBOSE[2693] logger.c: Found peer 'VON'
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Setting NAT on RTP to 524288
Jun 8 11:14:27 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 216.115.30.26:5060
Via: SIP/2.0/UDP 208.48.204.17:5060;branch=z9hG4bKCE8
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=2143609300
To: <sip:17653820296@inbound4.vonage.net>;tag=as788b0220
Call-ID: 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17
CSeq: 101 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:17653820296@192.168.1.12>
Proxy-Authenticate: Digest realm="asterisk", nonce="003e88b1"
Content-Length: 0
---
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #444
Jun 8 11:14:27 VERBOSE[2693] logger.c: Scheduling destruction of call '4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17' in 15000 ms
Jun 8 11:14:27 VERBOSE[2693] logger.c:
<-- SIP read from 216.115.20.41:5061:
ACK sip:17653820296@24.123.18.101:5060 SIP/2.0
Via: SIP/2.0/UDP 216.115.20.41:5061
From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=2143609300
To: <sip:17653820296@inbound4.vonage.net>;tag=as788b0220
Call-ID: 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17
CSeq: 101 ACK
Content-Length: 0
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 0: ACK sip:17653820296@24.123.18.101:5060 SIP/2.0 (46)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 216.115.20.41:5061 (35)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 2: From: "LOWMILLER HEATH" <sip:17652436199@208.48.204.17>;tag=2143609300 (70)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@inbound4.vonage.net>;tag=as788b0220 (56)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17 (58)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 5: CSeq: 101 ACK (13)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 6: Content-Length: 0 (17)
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Header 7: (0)
Jun 8 11:14:27 VERBOSE[2693] logger.c: --- (7 headers 0 lines)Jun 8 11:14:27 VERBOSE[2693] logger.c: --- (7 headers 0 lines)---
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #444
Jun 8 11:14:27 DEBUG[2693] chan_sip.c: Stopping retransmission on '4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17' of Response 101: Match Found
Jun 8 11:14:30 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.207:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKd791f829D1E5DAF4
From: "Jim" <sip:502@192.168.3.1>;tag=199B51E3-1C4C94F0
To: <sip:502@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: c8be9a47-feeee385-d4de06e2@192.168.3.207
Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKd791f829D1E5DAF4 (61)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 2: From: "Jim" <sip:502@192.168.3.1>;tag=199B51E3-1C4C94F0 (55)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 3: To: <sip:502@192.168.3.1> (25)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 5: Call-ID: c8be9a47-feeee385-d4de06e2@192.168.3.207 (49)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:30 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:14:30 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for c8be9a47-feeee385-d4de06e2@192.168.3.207 - REGISTER (No RTP)
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:30 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:14:30 VERBOSE[2693] logger.c: Sending to 192.168.3.207 : 5060 (non-NAT)
Jun 8 11:14:30 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.207:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKd791f829D1E5DAF4;received=192.168.3.207
From: "Jim" <sip:502@192.168.3.1>;tag=199B51E3-1C4C94F0
To: <sip:502@192.168.3.1>;tag=as728e3697
Call-ID: c8be9a47-feeee385-d4de06e2@192.168.3.207
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:502@192.168.3.1>
Content-Length: 0
---
Jun 8 11:14:30 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:30 NOTICE[2693] chan_sip.c: Registration from '<sip:502@192.168.3.1>' failed for '192.168.3.207' - Username/auth name mismatch
Jun 8 11:14:30 VERBOSE[2693] logger.c: Scheduling destruction of call 'c8be9a47-feeee385-d4de06e2@192.168.3.207' in 15000 ms
Jun 8 11:14:33 VERBOSE[2719] logger.c: -- Remote UNIX connection disconnected
Jun 8 11:14:33 DEBUG[2693] chan_sip.c: Auto destroying call '24a68dd-9db95bbf-cf35e054@192.168.3.202'
Jun 8 11:14:33 VERBOSE[2693] logger.c: Destroying call '24a68dd-9db95bbf-cf35e054@192.168.3.202'
Jun 8 11:14:35 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.112:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK94c5e214B8CBC47F
From: "Ben" <sip:503@192.168.3.1>;tag=C34D3BA6-259D9B8B
To: <sip:503@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: b2e866da-91966760-214e0c25@192.168.3.112
Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK94c5e214B8CBC47F (61)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 2: From: "Ben" <sip:503@192.168.3.1>;tag=C34D3BA6-259D9B8B (55)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 3: To: <sip:503@192.168.3.1> (25)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 5: Call-ID: b2e866da-91966760-214e0c25@192.168.3.112 (49)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:35 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:14:35 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for b2e866da-91966760-214e0c25@192.168.3.112 - REGISTER (No RTP)
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:35 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:14:35 VERBOSE[2693] logger.c: Sending to 192.168.3.112 : 5060 (non-NAT)
Jun 8 11:14:35 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.112:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK94c5e214B8CBC47F;received=192.168.3.112
From: "Ben" <sip:503@192.168.3.1>;tag=C34D3BA6-259D9B8B
To: <sip:503@192.168.3.1>;tag=as65a95597
Call-ID: b2e866da-91966760-214e0c25@192.168.3.112
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:503@192.168.3.1>
Content-Length: 0
---
Jun 8 11:14:35 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:35 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:14:35 VERBOSE[2693] logger.c: Scheduling destruction of call 'b2e866da-91966760-214e0c25@192.168.3.112' in 15000 ms
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Auto destroying call '4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17'
Jun 8 11:14:42 VERBOSE[2693] logger.c: Destroying call '4F5C9874-F63811DA-A682ADA4-BC992F66@208.48.204.17'
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:42 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:42 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:42 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #448
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4a44a31e;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as25c2d74a (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:42 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=z9hG4bK4a44a31e;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as25c2d74a
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 127 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #449
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #450
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5971c27e;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as2bc510d8 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:42 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=z9hG4bK5971c27e;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as2bc510d8
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 127 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #451
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #452
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0bc45cee;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as30e41613 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:42 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=z9hG4bK0bc45cee;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as30e41613
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 127 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #453
Jun 8 11:14:42 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=z9hG4bK4a44a31e;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as25c2d74a
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 127 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4a44a31e;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as25c2d74a (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #449
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 127: Match Found
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Cancelling timeout 448
Jun 8 11:14:42 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:42 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=z9hG4bK5971c27e;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as2bc510d8
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 127 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5971c27e;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as2bc510d8 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #451
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 127: Match Found
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Cancelling timeout 450
Jun 8 11:14:42 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:42 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:42 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=z9hG4bK0bc45cee;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as30e41613
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 127 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0bc45cee;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as30e41613 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #453
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 127: Match Found
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Cancelling timeout 452
Jun 8 11:14:42 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #460
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK62df6a24;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as4233d012 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:42 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:42 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=z9hG4bK62df6a24;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as4233d012
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 127 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #461
Jun 8 11:14:42 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=z9hG4bK62df6a24;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as4233d012
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 127 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK62df6a24;rport (63)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as4233d012 (61)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 5: CSeq: 127 REGISTER (18)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:42 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #461
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 127: Match Found
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:42 DEBUG[2693] chan_sip.c: Cancelling timeout 460
Jun 8 11:14:42 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:14:42 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:45 DEBUG[2693] chan_sip.c: Auto destroying call 'c8be9a47-feeee385-d4de06e2@192.168.3.207'
Jun 8 11:14:45 VERBOSE[2693] logger.c: Destroying call 'c8be9a47-feeee385-d4de06e2@192.168.3.207'
Jun 8 11:14:50 DEBUG[2693] chan_sip.c: Auto destroying call 'b2e866da-91966760-214e0c25@192.168.3.112'
Jun 8 11:14:50 VERBOSE[2693] logger.c: Destroying call 'b2e866da-91966760-214e0c25@192.168.3.112'
Jun 8 11:14:54 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.114:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKd282ff693EB81C16
From: "Darrin" <sip:505@192.168.3.1>;tag=1B1FA6E3-BC025C72
To: <sip:505@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: 657c7b97-e3182395-cb98fdbc@192.168.3.114
Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKd282ff693EB81C16 (61)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=1B1FA6E3-BC025C72 (58)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 657c7b97-e3182395-cb98fdbc@192.168.3.114 (49)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:14:54 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:14:54 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 657c7b97-e3182395-cb98fdbc@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:14:54 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:14:54 VERBOSE[2693] logger.c: Sending to 192.168.3.114 : 5060 (non-NAT)
Jun 8 11:14:54 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.114:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bKd282ff693EB81C16;received=192.168.3.114
From: "Darrin" <sip:505@192.168.3.1>;tag=1B1FA6E3-BC025C72
To: <sip:505@192.168.3.1>;tag=as22c84a64
Call-ID: 657c7b97-e3182395-cb98fdbc@192.168.3.114
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:505@192.168.3.1>
Content-Length: 0
---
Jun 8 11:14:54 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:14:54 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:14:54 VERBOSE[2693] logger.c: Scheduling destruction of call '657c7b97-e3182395-cb98fdbc@192.168.3.114' in 15000 ms
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:58 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:58 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:58 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #465
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK180fe33c;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as73d8ec2b (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:14:58 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=z9hG4bK180fe33c;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as73d8ec2b
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 128 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #466
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #467
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0dc66fd7;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as22cf90da (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:14:58 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=z9hG4bK0dc66fd7;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as22cf90da
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 128 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #468
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #469
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK25d41a91;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as18320f97 (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:58 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:14:58 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=z9hG4bK25d41a91;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as18320f97
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 128 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #470
Jun 8 11:14:58 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=z9hG4bK180fe33c;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as73d8ec2b
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 128 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK180fe33c;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as73d8ec2b (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #466
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 128: Match Found
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Cancelling timeout 465
Jun 8 11:14:58 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:58 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=z9hG4bK0dc66fd7;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as22cf90da
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 128 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0dc66fd7;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as22cf90da (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #468
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 128: Match Found
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Cancelling timeout 467
Jun 8 11:14:58 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:58 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:14:58 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=z9hG4bK25d41a91;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as18320f97
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 128 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK25d41a91;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as18320f97 (61)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:58 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #470
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 128: Match Found
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Cancelling timeout 469
Jun 8 11:14:58 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:14:58 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #477
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK245493dd;rport (63)
Jun 8 11:14:58 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0b5b2cad (61)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:14:59 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:14:59 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:14:59 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=z9hG4bK245493dd;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0b5b2cad
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 128 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #478
Jun 8 11:14:59 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=z9hG4bK245493dd;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0b5b2cad
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 128 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK245493dd;rport (63)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as0b5b2cad (61)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 5: CSeq: 128 REGISTER (18)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:14:59 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:14:59 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #478
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 128: Match Found
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:14:59 DEBUG[2693] chan_sip.c: Cancelling timeout 477
Jun 8 11:14:59 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:14:59 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:09 DEBUG[2693] chan_sip.c: Auto destroying call '657c7b97-e3182395-cb98fdbc@192.168.3.114'
Jun 8 11:15:09 VERBOSE[2693] logger.c: Destroying call '657c7b97-e3182395-cb98fdbc@192.168.3.114'
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:14 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:14 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:14 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:14 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #481
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK45a1074f;rport (63)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as33688c3c (61)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:14 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=z9hG4bK45a1074f;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as33688c3c
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 129 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #482
Jun 8 11:15:14 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #483
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK23f4953b;rport (63)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1ae6f85a (61)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:14 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=z9hG4bK23f4953b;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1ae6f85a
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 129 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #484
Jun 8 11:15:14 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #485
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK71902297;rport (63)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as7fc323f7 (61)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:14 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:14 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=z9hG4bK71902297;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as7fc323f7
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 129 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #486
Jun 8 11:15:14 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=z9hG4bK45a1074f;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as33688c3c
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 129 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK45a1074f;rport (63)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as33688c3c (61)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:14 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:14 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #482
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 129: Match Found
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Cancelling timeout 481
Jun 8 11:15:14 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:15:14 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:14 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=z9hG4bK23f4953b;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1ae6f85a
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 129 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK23f4953b;rport (63)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as1ae6f85a (61)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:14 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:14 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #484
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 129: Match Found
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Cancelling timeout 483
Jun 8 11:15:14 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:15:14 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:14 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:14 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:15 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=z9hG4bK71902297;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as7fc323f7
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 129 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK71902297;rport (63)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as7fc323f7 (61)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:15 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:15 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #486
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 129: Match Found
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Cancelling timeout 485
Jun 8 11:15:15 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:15:15 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:15 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #493
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK11030216;rport (63)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7715e279 (61)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:15 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:15 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:15 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=z9hG4bK11030216;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7715e279
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 129 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #494
Jun 8 11:15:15 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=z9hG4bK11030216;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7715e279
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 129 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK11030216;rport (63)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7715e279 (61)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 5: CSeq: 129 REGISTER (18)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:15 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:15 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #494
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 129: Match Found
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:15 DEBUG[2693] chan_sip.c: Cancelling timeout 493
Jun 8 11:15:15 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:15:15 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:16 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.202:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK9d63ccb2AD459745
From: "Kelly" <sip:500@192.168.3.1>;tag=7988E720-57844859
To: <sip:500@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: 639e3c9c-a93d2096-4321b867@192.168.3.202
Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK9d63ccb2AD459745 (61)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 2: From: "Kelly" <sip:500@192.168.3.1>;tag=7988E720-57844859 (57)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 3: To: <sip:500@192.168.3.1> (25)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 639e3c9c-a93d2096-4321b867@192.168.3.202 (49)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041 (54)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:15:16 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:15:16 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 639e3c9c-a93d2096-4321b867@192.168.3.202 - REGISTER (No RTP)
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:15:16 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:15:16 VERBOSE[2693] logger.c: Sending to 192.168.3.202 : 5060 (non-NAT)
Jun 8 11:15:16 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.202:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK9d63ccb2AD459745;received=192.168.3.202
From: "Kelly" <sip:500@192.168.3.1>;tag=7988E720-57844859
To: <sip:500@192.168.3.1>;tag=as39551195
Call-ID: 639e3c9c-a93d2096-4321b867@192.168.3.202
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:500@192.168.3.1>
Content-Length: 0
---
Jun 8 11:15:16 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:15:16 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:15:16 VERBOSE[2693] logger.c: Scheduling destruction of call '639e3c9c-a93d2096-4321b867@192.168.3.202' in 15000 ms
Jun 8 11:15:18 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.112:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK881ef1971DDBF72
From: "Ben" <sip:503@192.168.3.1>;tag=A27924C9-4010B23E
To: <sip:503@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: dfff683d-bca86a3-2ae51ef8@192.168.3.112
Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK881ef1971DDBF72 (60)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 2: From: "Ben" <sip:503@192.168.3.1>;tag=A27924C9-4010B23E (55)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 3: To: <sip:503@192.168.3.1> (25)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 5: Call-ID: dfff683d-bca86a3-2ae51ef8@192.168.3.112 (48)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:503@192.168.3.112>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:15:18 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:15:18 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for dfff683d-bca86a3-2ae51ef8@192.168.3.112 - REGISTER (No RTP)
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:15:18 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:15:18 VERBOSE[2693] logger.c: Sending to 192.168.3.112 : 5060 (non-NAT)
Jun 8 11:15:18 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.112:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.112;branch=z9hG4bK881ef1971DDBF72;received=192.168.3.112
From: "Ben" <sip:503@192.168.3.1>;tag=A27924C9-4010B23E
To: <sip:503@192.168.3.1>;tag=as63d2bfdd
Call-ID: dfff683d-bca86a3-2ae51ef8@192.168.3.112
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:503@192.168.3.1>
Content-Length: 0
---
Jun 8 11:15:18 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:15:18 NOTICE[2693] chan_sip.c: Registration from '<sip:503@192.168.3.1>' failed for '192.168.3.112' - Username/auth name mismatch
Jun 8 11:15:18 VERBOSE[2693] logger.c: Scheduling destruction of call 'dfff683d-bca86a3-2ae51ef8@192.168.3.112' in 15000 ms
Jun 8 11:15:29 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.207:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKe3f62f6cF3FE35FF
From: "Jim" <sip:502@192.168.3.1>;tag=738F2516-CA7DB69B
To: <sip:502@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: 6f2a37da-1c429a68-9e1347bd@192.168.3.207
Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKe3f62f6cF3FE35FF (61)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 2: From: "Jim" <sip:502@192.168.3.1>;tag=738F2516-CA7DB69B (55)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 3: To: <sip:502@192.168.3.1> (25)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 5: Call-ID: 6f2a37da-1c429a68-9e1347bd@192.168.3.207 (49)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:502@192.168.3.207>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:15:29 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:15:29 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6f2a37da-1c429a68-9e1347bd@192.168.3.207 - REGISTER (No RTP)
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:15:29 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:15:29 VERBOSE[2693] logger.c: Sending to 192.168.3.207 : 5060 (non-NAT)
Jun 8 11:15:29 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.207:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.207;branch=z9hG4bKe3f62f6cF3FE35FF;received=192.168.3.207
From: "Jim" <sip:502@192.168.3.1>;tag=738F2516-CA7DB69B
To: <sip:502@192.168.3.1>;tag=as22c3e96f
Call-ID: 6f2a37da-1c429a68-9e1347bd@192.168.3.207
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:502@192.168.3.1>
Content-Length: 0
---
Jun 8 11:15:29 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:15:29 NOTICE[2693] chan_sip.c: Registration from '<sip:502@192.168.3.1>' failed for '192.168.3.207' - Username/auth name mismatch
Jun 8 11:15:29 VERBOSE[2693] logger.c: Scheduling destruction of call '6f2a37da-1c429a68-9e1347bd@192.168.3.207' in 15000 ms
Jun 8 11:15:30 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.114:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bK4ecc2b0e988E816F
From: "Darrin" <sip:505@192.168.3.1>;tag=F3CF5E70-61D3D73B
To: <sip:505@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: e728a1f4-7f1f63ea-3c125bad@192.168.3.114
Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bK4ecc2b0e988E816F (61)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 2: From: "Darrin" <sip:505@192.168.3.1>;tag=F3CF5E70-61D3D73B (58)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 3: To: <sip:505@192.168.3.1> (25)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 5: Call-ID: e728a1f4-7f1f63ea-3c125bad@192.168.3.114 (49)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:505@192.168.3.114>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_501-UA/1.6.3.0067 (54)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:15:30 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:15:30 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for e728a1f4-7f1f63ea-3c125bad@192.168.3.114 - REGISTER (No RTP)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:15:30 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:15:30 VERBOSE[2693] logger.c: Sending to 192.168.3.114 : 5060 (non-NAT)
Jun 8 11:15:30 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.114:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.114;branch=z9hG4bK4ecc2b0e988E816F;received=192.168.3.114
From: "Darrin" <sip:505@192.168.3.1>;tag=F3CF5E70-61D3D73B
To: <sip:505@192.168.3.1>;tag=as191bd119
Call-ID: e728a1f4-7f1f63ea-3c125bad@192.168.3.114
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:505@192.168.3.1>
Content-Length: 0
---
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:15:30 NOTICE[2693] chan_sip.c: Registration from '<sip:505@192.168.3.1>' failed for '192.168.3.114' - Username/auth name mismatch
Jun 8 11:15:30 VERBOSE[2693] logger.c: Scheduling destruction of call 'e728a1f4-7f1f63ea-3c125bad@192.168.3.114' in 15000 ms
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:30 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:30 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:30 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:30 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #501
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK306cf16d;rport (63)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4937b986 (61)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:30 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:30 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:30 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=z9hG4bK306cf16d;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4937b986
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 130 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #502
Jun 8 11:15:30 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #503
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5aa62932;rport (63)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as18871abf (61)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:30 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:30 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:30 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=z9hG4bK5aa62932;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as18871abf
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 130 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:30 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #504
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #505
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK472207df;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as6192dc7d (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:31 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:31 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=z9hG4bK472207df;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as6192dc7d
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 130 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #506
Jun 8 11:15:31 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=z9hG4bK306cf16d;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4937b986
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 130 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK306cf16d;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as4937b986 (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #502
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 130: Match Found
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Cancelling timeout 501
Jun 8 11:15:31 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:31 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=z9hG4bK5aa62932;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as18871abf
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 130 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK5aa62932;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as18871abf (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #504
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 130: Match Found
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Cancelling timeout 503
Jun 8 11:15:31 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:31 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=z9hG4bK472207df;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as6192dc7d
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 130 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK472207df;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as6192dc7d (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #506
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 130: Match Found
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Cancelling timeout 505
Jun 8 11:15:31 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:31 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #513
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4111bdbc;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7316462e (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:31 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:31 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=z9hG4bK4111bdbc;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7316462e
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 130 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #514
Jun 8 11:15:31 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=z9hG4bK4111bdbc;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7316462e
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 130 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK4111bdbc;rport (63)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as7316462e (61)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 5: CSeq: 130 REGISTER (18)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:31 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #514
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 130: Match Found
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Cancelling timeout 513
Jun 8 11:15:31 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:15:31 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:31 DEBUG[2693] chan_sip.c: Auto destroying call '639e3c9c-a93d2096-4321b867@192.168.3.202'
Jun 8 11:15:31 VERBOSE[2693] logger.c: Destroying call '639e3c9c-a93d2096-4321b867@192.168.3.202'
Jun 8 11:15:33 DEBUG[2693] chan_sip.c: Auto destroying call 'dfff683d-bca86a3-2ae51ef8@192.168.3.112'
Jun 8 11:15:33 VERBOSE[2693] logger.c: Destroying call 'dfff683d-bca86a3-2ae51ef8@192.168.3.112'
Jun 8 11:15:44 DEBUG[2693] chan_sip.c: Auto destroying call '6f2a37da-1c429a68-9e1347bd@192.168.3.207'
Jun 8 11:15:44 VERBOSE[2693] logger.c: Destroying call '6f2a37da-1c429a68-9e1347bd@192.168.3.207'
Jun 8 11:15:45 DEBUG[2693] chan_sip.c: Auto destroying call 'e728a1f4-7f1f63ea-3c125bad@192.168.3.114'
Jun 8 11:15:45 VERBOSE[2693] logger.c: Destroying call 'e728a1f4-7f1f63ea-3c125bad@192.168.3.114'
Jun 8 11:15:46 DEBUG[2693] chan_sip.c: Auto destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:46 VERBOSE[2693] logger.c: Destroying call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1'
Jun 8 11:15:46 DEBUG[2693] chan_sip.c: Auto destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:46 VERBOSE[2693] logger.c: Destroying call '173ff13378c011274051c09229acbe69@127.0.0.1'
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Auto destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:47 VERBOSE[2693] logger.c: Destroying call '6bbf47710cf80958186767fa185ebb03@127.0.0.1'
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #517
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0f6e70ce;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as400b7b19 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820293@sphone.vopr.vonage.net
Jun 8 11:15:47 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=z9hG4bK0f6e70ce;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as400b7b19
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 131 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #518
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 173ff13378c011274051c09229acbe69@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #519
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK24b45fe1;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as5d8e0a59 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820294@sphone.vopr.vonage.net
Jun 8 11:15:47 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=z9hG4bK24b45fe1;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as5d8e0a59
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 131 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #520
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 6bbf47710cf80958186767fa185ebb03@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #521
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK56f4f4af;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as389a0645 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820295@sphone.vopr.vonage.net
Jun 8 11:15:47 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=z9hG4bK56f4f4af;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as389a0645
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 131 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #522
Jun 8 11:15:47 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=z9hG4bK0f6e70ce;rport
From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as400b7b19
To: <sip:17653820293@sphone.vopr.vonage.net>
Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1
CSeq: 131 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK0f6e70ce;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820293@sphone.vopr.vonage.net>;tag=as400b7b19 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820293@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 16407e723fc9b70e63a1998015f5efc0@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #518
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Stopping retransmission on '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' of Request 131: Match Found
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Cancelling timeout 517
Jun 8 11:15:47 VERBOSE[2693] logger.c: Scheduling destruction of call '16407e723fc9b70e63a1998015f5efc0@127.0.0.1' in 32000 ms
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:47 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=z9hG4bK24b45fe1;rport
From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as5d8e0a59
To: <sip:17653820294@sphone.vopr.vonage.net>
Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1
CSeq: 131 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK24b45fe1;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820294@sphone.vopr.vonage.net>;tag=as5d8e0a59 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820294@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 173ff13378c011274051c09229acbe69@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #520
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Stopping retransmission on '173ff13378c011274051c09229acbe69@127.0.0.1' of Request 131: Match Found
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Cancelling timeout 519
Jun 8 11:15:47 VERBOSE[2693] logger.c: Scheduling destruction of call '173ff13378c011274051c09229acbe69@127.0.0.1' in 32000 ms
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:47 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=z9hG4bK56f4f4af;rport
From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as389a0645
To: <sip:17653820295@sphone.vopr.vonage.net>
Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1
CSeq: 131 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK56f4f4af;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820295@sphone.vopr.vonage.net>;tag=as389a0645 (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820295@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 6bbf47710cf80958186767fa185ebb03@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #522
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Stopping retransmission on '6bbf47710cf80958186767fa185ebb03@127.0.0.1' of Request 131: Match Found
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Cancelling timeout 521
Jun 8 11:15:47 VERBOSE[2693] logger.c: Scheduling destruction of call '6bbf47710cf80958186767fa185ebb03@127.0.0.1' in 32000 ms
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Auto destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:47 VERBOSE[2693] logger.c: Destroying call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1'
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: -- Re-registration for 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 - REGISTER (No RTP)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Scheduled a registration timeout for sphone.vopr.vonage.net id #529
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:sphone.vopr.vonage.net SIP/2.0 (43)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK78aec6a1;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as09e9399e (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: User-Agent: Asterisk PBX (24)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Max-Forwards: 70 (16)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: Expires: 120 (12)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 9: Contact: <sip:s@192.168.1.12> (29)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 10: Event: registration (19)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 11: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 12: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER 12 headers, 0 lines
Jun 8 11:15:47 VERBOSE[2693] logger.c: REGISTER attempt 1 to 17653820296@sphone.vopr.vonage.net
Jun 8 11:15:47 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=z9hG4bK78aec6a1;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as09e9399e
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 131 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 120
Contact: <sip:s@192.168.1.12>
Event: registration
Content-Length: 0
---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: *** SIP TIMER: Initalizing retransmit timer on packet: Id #530
Jun 8 11:15:47 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=z9hG4bK78aec6a1;rport
From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as09e9399e
To: <sip:17653820296@sphone.vopr.vonage.net>
Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1
CSeq: 131 REGISTER
Contact: <sip:s@192.168.1.12>;expires=20
Content-Length: 0
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 0: SIP/2.0 200 OK (14)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK78aec6a1;rport (63)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 2: From: <sip:17653820296@sphone.vopr.vonage.net>;tag=as09e9399e (61)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 3: To: <sip:17653820296@sphone.vopr.vonage.net> (44)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 4: Call-ID: 0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1 (51)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 5: CSeq: 131 REGISTER (18)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:s@192.168.1.12>;expires=20 (40)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 7: Content-Length: 0 (17)
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Header 8: (0)
Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)Jun 8 11:15:47 VERBOSE[2693] logger.c: --- (8 headers 0 lines)---
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #530
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Stopping retransmission on '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' of Request 131: Match Found
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Registration successful
Jun 8 11:15:47 DEBUG[2693] chan_sip.c: Cancelling timeout 529
Jun 8 11:15:47 VERBOSE[2693] logger.c: Scheduling destruction of call '0829c5b10e3f9d130a9c5d4e4d7ffe71@127.0.0.1' in 32000 ms
Jun 8 11:15:47 NOTICE[2693] chan_sip.c: Outbound Registration: Expiry for sphone.vopr.vonage.net is 20 sec (Scheduling reregistration in 15 s)
Jun 8 11:15:51 VERBOSE[2693] logger.c:
<-- SIP read from 192.168.3.202:5060:
REGISTER sip:192.168.3.1:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK247dbaad6C7829E4
From: "Kelly" <sip:500@192.168.3.1>;tag=F1E47C3-7A9488E8
To: <sip:500@192.168.3.1>
CSeq: 1 REGISTER
Call-ID: c789120f-9e190241-4f0eb71e@192.168.3.202
Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041
Max-Forwards: 70
Expires: 3600
Content-Length: 0
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 0: REGISTER sip:192.168.3.1:5060 SIP/2.0 (37)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 1: Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK247dbaad6C7829E4 (61)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 2: From: "Kelly" <sip:500@192.168.3.1>;tag=F1E47C3-7A9488E8 (56)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 3: To: <sip:500@192.168.3.1> (25)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 4: CSeq: 1 REGISTER (16)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 5: Call-ID: c789120f-9e190241-4f0eb71e@192.168.3.202 (49)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 6: Contact: <sip:500@192.168.3.202>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" (132)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 7: User-Agent: PolycomSoundPointIP-SPIP_601-UA/1.6.2.0041 (54)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 8: Max-Forwards: 70 (16)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 9: Expires: 3600 (13)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 10: Content-Length: 0 (17)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Header 11: (0)
Jun 8 11:15:51 VERBOSE[2693] logger.c: --- (11 headers 0 lines)Jun 8 11:15:51 VERBOSE[2693] logger.c: --- (11 headers 0 lines)---
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: Allocating new SIP dialog for c789120f-9e190241-4f0eb71e@192.168.3.202 - REGISTER (No RTP)
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: **** Received REGISTER (2) - Command in SIP REGISTER
Jun 8 11:15:51 VERBOSE[2693] logger.c: Using latest REGISTER request as basis request
Jun 8 11:15:51 VERBOSE[2693] logger.c: Sending to 192.168.3.202 : 5060 (non-NAT)
Jun 8 11:15:51 VERBOSE[2693] logger.c: Transmitting (no NAT) to 192.168.3.202:5060:
SIP/2.0 404 Not found
Via: SIP/2.0/UDP 192.168.3.202;branch=z9hG4bK247dbaad6C7829E4;received=192.168.3.202
From: "Kelly" <sip:500@192.168.3.1>;tag=F1E47C3-7A9488E8
To: <sip:500@192.168.3.1>;tag=as66c3b2c0
Call-ID: c789120f-9e190241-4f0eb71e@192.168.3.202
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:500@192.168.3.1>
Content-Length: 0
---
Jun 8 11:15:51 DEBUG[2693] chan_sip.c: SIP REGISTER attempt failed for (null) : Bad digest user
Jun 8 11:15:51 NOTICE[2693] chan_sip.c: Registration from '<sip:500@192.168.3.1>' failed for '192.168.3.202' - Username/auth name mismatch
Jun 8 11:15:51 VERBOSE[2693] logger.c: Scheduling destruction of call 'c789120f-9e190241-4f0eb71e@192.168.3.202' in 15000 ms