Aug 29 11:19:42 VERBOSE[8578] logger.c: Asterisk Event Logger restarted Aug 29 11:20:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.203:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK285953e3CCB43DAA From: "Theater" ;tag=AE4F6013-26080F40 To: CSeq: 4611 REGISTER Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="theater-polycom", realm="asterisk", nonce="20c05d59", uri="sip:10.1.1.48:5060", response="dd082636ece4b84c3c4457f3fdd39a45", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:20:33 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:20:33 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:20:33 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:20:33 VERBOSE[8578] logger.c: Sending to 10.1.1.203 : 5060 (non-NAT) Aug 29 11:20:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.203:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK285953e3CCB43DAA From: "Theater" ;tag=AE4F6013-26080F40 To: Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 CSeq: 4611 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:20:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.203:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK285953e3CCB43DAA From: "Theater" ;tag=AE4F6013-26080F40 To: ;tag=as734a762b Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 CSeq: 4611 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="38e2e1b9" Content-Length: 0 --- Aug 29 11:20:33 VERBOSE[8578] logger.c: Scheduling destruction of call 'f0f813df-6d3891b1-a44883b6@10.1.1.203' in 15000 ms Aug 29 11:20:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.203:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK19cff5d58C972CD4 From: "Theater" ;tag=AE4F6013-26080F40 To: CSeq: 4612 REGISTER Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="theater-polycom", realm="asterisk", nonce="38e2e1b9", uri="sip:10.1.1.48:5060", response="99216394536ea74be7a9aa7c85272666", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:20:33 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:20:33 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:20:33 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:20:33 VERBOSE[8578] logger.c: Sending to 10.1.1.203 : 5060 (non-NAT) Aug 29 11:20:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.203:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK19cff5d58C972CD4 From: "Theater" ;tag=AE4F6013-26080F40 To: Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 CSeq: 4612 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:20:33 VERBOSE[8578] logger.c: -- Saved useragent "PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054" for peer theater-polycom Aug 29 11:20:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.203:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.203;branch=z9hG4bK19cff5d58C972CD4 From: "Theater" ;tag=AE4F6013-26080F40 To: ;tag=as734a762b Call-ID: f0f813df-6d3891b1-a44883b6@10.1.1.203 CSeq: 4612 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Date: Mon, 29 Aug 2005 18:20:33 GMT Content-Length: 0 --- Aug 29 11:20:33 VERBOSE[8578] logger.c: Scheduling destruction of call 'f0f813df-6d3891b1-a44883b6@10.1.1.203' in 15000 ms Aug 29 11:20:36 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.202:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKd5f19a5aFE126ACB From: "Guest Room" ;tag=E3FF891A-A4694311 To: CSeq: 285 REGISTER Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="guest-room-polycom", realm="asterisk", nonce="1d13e926", uri="sip:10.1.1.48:5060", response="0a74bee04daa4fd612bbf93a7ab0ce24", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:20:36 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:20:36 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:20:36 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:20:36 VERBOSE[8578] logger.c: Sending to 10.1.1.202 : 5060 (non-NAT) Aug 29 11:20:36 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.202:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKd5f19a5aFE126ACB From: "Guest Room" ;tag=E3FF891A-A4694311 To: Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 CSeq: 285 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:20:36 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.202:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKd5f19a5aFE126ACB From: "Guest Room" ;tag=E3FF891A-A4694311 To: ;tag=as22b14ff4 Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 CSeq: 285 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="210b4c07" Content-Length: 0 --- Aug 29 11:20:36 VERBOSE[8578] logger.c: Scheduling destruction of call 'f8c7b6e6-99902730-b4f8b137@10.1.1.202' in 15000 ms Aug 29 11:20:36 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.202:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKebb30be423BEEFE5 From: "Guest Room" ;tag=E3FF891A-A4694311 To: CSeq: 286 REGISTER Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="guest-room-polycom", realm="asterisk", nonce="210b4c07", uri="sip:10.1.1.48:5060", response="c2b0f08d048f83a437b126de1d022078", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:20:36 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:20:36 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:20:36 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:20:36 VERBOSE[8578] logger.c: Sending to 10.1.1.202 : 5060 (non-NAT) Aug 29 11:20:36 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.202:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKebb30be423BEEFE5 From: "Guest Room" ;tag=E3FF891A-A4694311 To: Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 CSeq: 286 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:20:36 VERBOSE[8578] logger.c: -- Saved useragent "PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054" for peer guest-room-polycom Aug 29 11:20:36 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.202:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.202;branch=z9hG4bKebb30be423BEEFE5 From: "Guest Room" ;tag=E3FF891A-A4694311 To: ;tag=as22b14ff4 Call-ID: f8c7b6e6-99902730-b4f8b137@10.1.1.202 CSeq: 286 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Date: Mon, 29 Aug 2005 18:20:36 GMT Content-Length: 0 --- Aug 29 11:20:36 VERBOSE[8578] logger.c: Scheduling destruction of call 'f8c7b6e6-99902730-b4f8b137@10.1.1.202' in 15000 ms Aug 29 11:20:48 DEBUG[8578] chan_sip.c: Auto destroying call 'f0f813df-6d3891b1-a44883b6@10.1.1.203' Aug 29 11:20:48 VERBOSE[8578] logger.c: Destroying call 'f0f813df-6d3891b1-a44883b6@10.1.1.203' Aug 29 11:20:51 DEBUG[8578] chan_sip.c: Auto destroying call 'f8c7b6e6-99902730-b4f8b137@10.1.1.202' Aug 29 11:20:51 VERBOSE[8578] logger.c: Destroying call 'f8c7b6e6-99902730-b4f8b137@10.1.1.202' Aug 29 11:22:06 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK3481d598B50BFE5B From: "Wilson" ;tag=8A80104A-A7EE6827 To: CSeq: 1 REGISTER Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:06 VERBOSE[8578] logger.c: --- (11 headers 0 lines)Aug 29 11:22:06 VERBOSE[8578] logger.c: --- (11 headers 0 lines)--- Aug 29 11:22:06 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:22:06 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:06 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK3481d598B50BFE5B From: "Wilson" ;tag=8A80104A-A7EE6827 To: Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 CSeq: 1 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:22:06 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK3481d598B50BFE5B From: "Wilson" ;tag=8A80104A-A7EE6827 To: ;tag=as7ae10cd9 Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 CSeq: 1 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="5e3f365d" Content-Length: 0 --- Aug 29 11:22:06 VERBOSE[8578] logger.c: Scheduling destruction of call '6d7d4efe-a9df97e4-97477381@10.1.1.200' in 15000 ms Aug 29 11:22:07 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8a343c4d66E1830 From: "Wilson" ;tag=8A80104A-A7EE6827 To: CSeq: 2 REGISTER Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="5e3f365d", uri="sip:10.1.1.48:5060", response="07266e144a41d8c133af69d91ba41576", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:22:07 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:22:07 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:07 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8a343c4d66E1830 From: "Wilson" ;tag=8A80104A-A7EE6827 To: Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 CSeq: 2 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:22:07 VERBOSE[8578] logger.c: -- Saved useragent "PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054" for peer wilson-polycom Aug 29 11:22:07 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8a343c4d66E1830 From: "Wilson" ;tag=8A80104A-A7EE6827 To: ;tag=as7ae10cd9 Call-ID: 6d7d4efe-a9df97e4-97477381@10.1.1.200 CSeq: 2 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Date: Mon, 29 Aug 2005 18:22:07 GMT Content-Length: 0 --- Aug 29 11:22:07 VERBOSE[8578] logger.c: Scheduling destruction of call '6d7d4efe-a9df97e4-97477381@10.1.1.200' in 15000 ms Aug 29 11:22:07 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKca844ff370F10F96 From: "Wilson" ;tag=A42BC7E5-CFEB4CE2 To: CSeq: 1 SUBSCRIBE Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:07 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:07 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:07 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:07 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKca844ff370F10F96 From: "Wilson" ;tag=A42BC7E5-CFEB4CE2 To: ;tag=as05e58937 Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="567d5034" Content-Length: 0 --- Aug 29 11:22:07 VERBOSE[8578] logger.c: Scheduling destruction of call 'a4820319-4908b5bf-ff88567c@10.1.1.200' in 15000 ms Aug 29 11:22:07 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6e0952c8A336998B From: "Wilson" ;tag=A42BC7E5-CFEB4CE2 To: CSeq: 2 SUBSCRIBE Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="567d5034", uri="sip:1002@10.1.1.48:5060", response="7f41c84186be7058edddeea8638493ef", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:07 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:07 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription a4820319-4908b5bf-ff88567c@10.1.1.200 Aug 29 11:22:07 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:07 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:07 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:07 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:07 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:07 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6e0952c8A336998B From: "Wilson" ;tag=A42BC7E5-CFEB4CE2 To: ;tag=as64af1cbc Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:07 VERBOSE[8578] logger.c: Scheduling destruction of call 'a4820319-4908b5bf-ff88567c@10.1.1.200' in 3610000 ms Aug 29 11:22:07 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK14a4cab2 From: ;tag=as64af1cbc To: "Wilson" ;tag=A42BC7E5-CFEB4CE2 Contact: Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:08 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK14a4cab2 From: ;tag=as64af1cbc To: "Wilson" ;tag=A42BC7E5-CFEB4CE2 CSeq: 102 NOTIFY Call-ID: a4820319-4908b5bf-ff88567c@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:08 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a4820319-4908b5bf-ff88567c@10.1.1.200' of Request 102: Match Found Aug 29 11:22:08 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:08 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKda09c82eFAAC8AB1 From: "Wilson" ;tag=402B8560-8CFF4B7D To: CSeq: 1 SUBSCRIBE Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:08 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:08 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:08 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:08 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKda09c82eFAAC8AB1 From: "Wilson" ;tag=402B8560-8CFF4B7D To: ;tag=as016a8f41 Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="2686f8a1" Content-Length: 0 --- Aug 29 11:22:08 VERBOSE[8578] logger.c: Scheduling destruction of call 'e4c0d14-567817a-6c48fb57@10.1.1.200' in 15000 ms Aug 29 11:22:08 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKafadb23CB9F78C6 From: "Wilson" ;tag=402B8560-8CFF4B7D To: CSeq: 2 SUBSCRIBE Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="2686f8a1", uri="sip:2000@10.1.1.48:5060", response="78c2b7635ab191bca0ec231c9a21a31a", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:08 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:08 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription e4c0d14-567817a-6c48fb57@10.1.1.200 Aug 29 11:22:08 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:08 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:08 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:08 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:08 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:08 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKafadb23CB9F78C6 From: "Wilson" ;tag=402B8560-8CFF4B7D To: ;tag=as03c5c570 Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:08 VERBOSE[8578] logger.c: Scheduling destruction of call 'e4c0d14-567817a-6c48fb57@10.1.1.200' in 3610000 ms Aug 29 11:22:08 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK71e21564 From: ;tag=as03c5c570 To: "Wilson" ;tag=402B8560-8CFF4B7D Contact: Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:09 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK71e21564 From: ;tag=as03c5c570 To: "Wilson" ;tag=402B8560-8CFF4B7D CSeq: 102 NOTIFY Call-ID: e4c0d14-567817a-6c48fb57@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:09 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e4c0d14-567817a-6c48fb57@10.1.1.200' of Request 102: Match Found Aug 29 11:22:09 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:09 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK739f0a49C702BBAC From: "Wilson" ;tag=5A914BB-89ACAFF8 To: CSeq: 1 SUBSCRIBE Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:09 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:09 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:09 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:09 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK739f0a49C702BBAC From: "Wilson" ;tag=5A914BB-89ACAFF8 To: ;tag=as4d93fb31 Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="031a3652" Content-Length: 0 --- Aug 29 11:22:09 VERBOSE[8578] logger.c: Scheduling destruction of call '798738ef-ba86c715-69ccae12@10.1.1.200' in 15000 ms Aug 29 11:22:09 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKa08a215e213181E1 From: "Wilson" ;tag=5A914BB-89ACAFF8 To: CSeq: 2 SUBSCRIBE Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="031a3652", uri="sip:1002@10.1.1.48:5060", response="a2e501d3fb6136501703f94cde97cd15", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:09 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:09 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 798738ef-ba86c715-69ccae12@10.1.1.200 Aug 29 11:22:09 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:09 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:09 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:09 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:09 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:09 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKa08a215e213181E1 From: "Wilson" ;tag=5A914BB-89ACAFF8 To: ;tag=as74599611 Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:09 VERBOSE[8578] logger.c: Scheduling destruction of call '798738ef-ba86c715-69ccae12@10.1.1.200' in 3610000 ms Aug 29 11:22:09 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6c5709b6 From: ;tag=as74599611 To: "Wilson" ;tag=5A914BB-89ACAFF8 Contact: Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:10 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6c5709b6 From: ;tag=as74599611 To: "Wilson" ;tag=5A914BB-89ACAFF8 CSeq: 102 NOTIFY Call-ID: 798738ef-ba86c715-69ccae12@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:10 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:10 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:10 DEBUG[8578] chan_sip.c: Stopping retransmission on '798738ef-ba86c715-69ccae12@10.1.1.200' of Request 102: Match Found Aug 29 11:22:10 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:10 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK52846244109B6E87 From: "Wilson" ;tag=EBA1C1F6-CF194653 To: CSeq: 1 SUBSCRIBE Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:10 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:10 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:10 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:10 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:10 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:10 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK52846244109B6E87 From: "Wilson" ;tag=EBA1C1F6-CF194653 To: ;tag=as0ffaf9a4 Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="74a4855d" Content-Length: 0 --- Aug 29 11:22:10 VERBOSE[8578] logger.c: Scheduling destruction of call '73f2d2aa-8f64d290-da9a3aad@10.1.1.200' in 15000 ms Aug 29 11:22:11 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK4d3bf17911A900DC From: "Wilson" ;tag=EBA1C1F6-CF194653 To: CSeq: 2 SUBSCRIBE Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="74a4855d", uri="sip:2000@10.1.1.48:5060", response="5a773c010190e9f9fae661c880fde575", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:11 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 Aug 29 11:22:11 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:11 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:11 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:11 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:11 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:11 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK4d3bf17911A900DC From: "Wilson" ;tag=EBA1C1F6-CF194653 To: ;tag=as73a0576b Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:11 VERBOSE[8578] logger.c: Scheduling destruction of call '73f2d2aa-8f64d290-da9a3aad@10.1.1.200' in 3610000 ms Aug 29 11:22:11 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0910c6c4 From: ;tag=as73a0576b To: "Wilson" ;tag=EBA1C1F6-CF194653 Contact: Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:11 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0910c6c4 From: ;tag=as73a0576b To: "Wilson" ;tag=EBA1C1F6-CF194653 CSeq: 102 NOTIFY Call-ID: 73f2d2aa-8f64d290-da9a3aad@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:11 DEBUG[8578] chan_sip.c: Stopping retransmission on '73f2d2aa-8f64d290-da9a3aad@10.1.1.200' of Request 102: Match Found Aug 29 11:22:11 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:11 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK95d9c1fD2B1EF42 From: "Wilson" ;tag=79965911-77BE5A8E To: CSeq: 1 SUBSCRIBE Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:11 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:11 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:11 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:11 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK95d9c1fD2B1EF42 From: "Wilson" ;tag=79965911-77BE5A8E To: ;tag=as11bea1b8 Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="74729ed8" Content-Length: 0 --- Aug 29 11:22:11 VERBOSE[8578] logger.c: Scheduling destruction of call 'd311a645-db236feb-ce2bed28@10.1.1.200' in 15000 ms Aug 29 11:22:11 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK9d48977473A5C1B7 From: "Wilson" ;tag=79965911-77BE5A8E To: CSeq: 2 SUBSCRIBE Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="74729ed8", uri="sip:1002@10.1.1.48:5060", response="23284ac24b400c2ee0bf68c5cf510a8c", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:11 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:11 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription d311a645-db236feb-ce2bed28@10.1.1.200 Aug 29 11:22:11 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:11 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:11 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:11 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:11 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:11 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK9d48977473A5C1B7 From: "Wilson" ;tag=79965911-77BE5A8E To: ;tag=as625e1f80 Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:11 VERBOSE[8578] logger.c: Scheduling destruction of call 'd311a645-db236feb-ce2bed28@10.1.1.200' in 3610000 ms Aug 29 11:22:11 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK10c384fe From: ;tag=as625e1f80 To: "Wilson" ;tag=79965911-77BE5A8E Contact: Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:12 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK10c384fe From: ;tag=as625e1f80 To: "Wilson" ;tag=79965911-77BE5A8E CSeq: 102 NOTIFY Call-ID: d311a645-db236feb-ce2bed28@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:12 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd311a645-db236feb-ce2bed28@10.1.1.200' of Request 102: Match Found Aug 29 11:22:12 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:12 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6ce203daC1C509DD From: "Wilson" ;tag=C63B260C-6018B8A9 To: CSeq: 1 SUBSCRIBE Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:12 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:12 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:12 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:12 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6ce203daC1C509DD From: "Wilson" ;tag=C63B260C-6018B8A9 To: ;tag=as463b24d5 Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="71bb6c3c" Content-Length: 0 --- Aug 29 11:22:12 VERBOSE[8578] logger.c: Scheduling destruction of call 'fad9ffc0-47b7eb26-d59f9183@10.1.1.200' in 15000 ms Aug 29 11:22:12 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK974bdf4f615B1072 From: "Wilson" ;tag=C63B260C-6018B8A9 To: CSeq: 2 SUBSCRIBE Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="71bb6c3c", uri="sip:2000@10.1.1.48:5060", response="d9bd6793ce6cba0fdea7c85eab501b12", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:12 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:12 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription fad9ffc0-47b7eb26-d59f9183@10.1.1.200 Aug 29 11:22:12 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:12 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:12 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:12 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:12 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:12 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK974bdf4f615B1072 From: "Wilson" ;tag=C63B260C-6018B8A9 To: ;tag=as5f7d9725 Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:12 VERBOSE[8578] logger.c: Scheduling destruction of call 'fad9ffc0-47b7eb26-d59f9183@10.1.1.200' in 3610000 ms Aug 29 11:22:12 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK09ec937b From: ;tag=as5f7d9725 To: "Wilson" ;tag=C63B260C-6018B8A9 Contact: Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:13 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK09ec937b From: ;tag=as5f7d9725 To: "Wilson" ;tag=C63B260C-6018B8A9 CSeq: 102 NOTIFY Call-ID: fad9ffc0-47b7eb26-d59f9183@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:13 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:13 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:13 DEBUG[8578] chan_sip.c: Stopping retransmission on 'fad9ffc0-47b7eb26-d59f9183@10.1.1.200' of Request 102: Match Found Aug 29 11:22:13 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:13 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKfc8c65752470A58 From: "Wilson" ;tag=F427F4E7-9558ACA4 To: CSeq: 1 SUBSCRIBE Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:13 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:13 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:13 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:13 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:13 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:13 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKfc8c65752470A58 From: "Wilson" ;tag=F427F4E7-9558ACA4 To: ;tag=as6c4a6cc2 Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="189f9604" Content-Length: 0 --- Aug 29 11:22:13 VERBOSE[8578] logger.c: Scheduling destruction of call 'a265ab1b-f29b1041-966673be@10.1.1.200' in 15000 ms Aug 29 11:22:14 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6f5150a113FB90D From: "Wilson" ;tag=F427F4E7-9558ACA4 To: CSeq: 2 SUBSCRIBE Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="189f9604", uri="sip:1002@10.1.1.48:5060", response="993dd064105b53f7f8a42b2895df334e", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:14 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription a265ab1b-f29b1041-966673be@10.1.1.200 Aug 29 11:22:14 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:14 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:14 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:14 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:14 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:14 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6f5150a113FB90D From: "Wilson" ;tag=F427F4E7-9558ACA4 To: ;tag=as54d299ea Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:14 VERBOSE[8578] logger.c: Scheduling destruction of call 'a265ab1b-f29b1041-966673be@10.1.1.200' in 3610000 ms Aug 29 11:22:14 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1578378b From: ;tag=as54d299ea To: "Wilson" ;tag=F427F4E7-9558ACA4 Contact: Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:14 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1578378b From: ;tag=as54d299ea To: "Wilson" ;tag=F427F4E7-9558ACA4 CSeq: 102 NOTIFY Call-ID: a265ab1b-f29b1041-966673be@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:14 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a265ab1b-f29b1041-966673be@10.1.1.200' of Request 102: Match Found Aug 29 11:22:14 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:14 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK94b0cf05D4DBCB3 From: "Wilson" ;tag=EC8811A2-4212027F To: CSeq: 1 SUBSCRIBE Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:14 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:14 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:14 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:14 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:14 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK94b0cf05D4DBCB3 From: "Wilson" ;tag=EC8811A2-4212027F To: ;tag=as53dbd8c4 Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="7fbcf8a6" Content-Length: 0 --- Aug 29 11:22:14 VERBOSE[8578] logger.c: Scheduling destruction of call 'd6a1f456-4b792b3c-5af55fd9@10.1.1.200' in 15000 ms Aug 29 11:22:15 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc5b704a56CBE0788 From: "Wilson" ;tag=EC8811A2-4212027F To: CSeq: 2 SUBSCRIBE Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="7fbcf8a6", uri="sip:2000@10.1.1.48:5060", response="59e05e9f7f3ea48c39a602c690cc1784", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:15 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription d6a1f456-4b792b3c-5af55fd9@10.1.1.200 Aug 29 11:22:15 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:15 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:15 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:15 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:15 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:15 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc5b704a56CBE0788 From: "Wilson" ;tag=EC8811A2-4212027F To: ;tag=as0a2aa8dc Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:15 VERBOSE[8578] logger.c: Scheduling destruction of call 'd6a1f456-4b792b3c-5af55fd9@10.1.1.200' in 3610000 ms Aug 29 11:22:15 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK65de7e83 From: ;tag=as0a2aa8dc To: "Wilson" ;tag=EC8811A2-4212027F Contact: Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:15 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK65de7e83 From: ;tag=as0a2aa8dc To: "Wilson" ;tag=EC8811A2-4212027F CSeq: 102 NOTIFY Call-ID: d6a1f456-4b792b3c-5af55fd9@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:15 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd6a1f456-4b792b3c-5af55fd9@10.1.1.200' of Request 102: Match Found Aug 29 11:22:15 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:15 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5a2fc64bB3426CEE From: "Wilson" ;tag=17CA483D-D8EC063A To: CSeq: 1 SUBSCRIBE Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:15 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:15 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:15 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:15 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:15 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5a2fc64bB3426CEE From: "Wilson" ;tag=17CA483D-D8EC063A To: ;tag=as5f7a5b91 Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="4ff8e78e" Content-Length: 0 --- Aug 29 11:22:15 VERBOSE[8578] logger.c: Scheduling destruction of call 'faffa771-70e20817-6174a1d4@10.1.1.200' in 15000 ms Aug 29 11:22:16 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc177fa2024E3C7E3 From: "Wilson" ;tag=17CA483D-D8EC063A To: CSeq: 2 SUBSCRIBE Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="4ff8e78e", uri="sip:1002@10.1.1.48:5060", response="882732049ca6ea3e02850b891fa4ca59", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:16 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription faffa771-70e20817-6174a1d4@10.1.1.200 Aug 29 11:22:16 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:16 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:16 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:16 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:16 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:16 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc177fa2024E3C7E3 From: "Wilson" ;tag=17CA483D-D8EC063A To: ;tag=as1bfdbfdf Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:16 VERBOSE[8578] logger.c: Scheduling destruction of call 'faffa771-70e20817-6174a1d4@10.1.1.200' in 3610000 ms Aug 29 11:22:16 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK091bd6e2 From: ;tag=as1bfdbfdf To: "Wilson" ;tag=17CA483D-D8EC063A Contact: Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:16 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK091bd6e2 From: ;tag=as1bfdbfdf To: "Wilson" ;tag=17CA483D-D8EC063A CSeq: 102 NOTIFY Call-ID: faffa771-70e20817-6174a1d4@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:16 DEBUG[8578] chan_sip.c: Stopping retransmission on 'faffa771-70e20817-6174a1d4@10.1.1.200' of Request 102: Match Found Aug 29 11:22:16 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:16 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKf1fdd866C91E709 From: "Wilson" ;tag=D450E4B8-3D5183D5 To: CSeq: 1 SUBSCRIBE Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:16 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:16 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:16 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:16 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKf1fdd866C91E709 From: "Wilson" ;tag=D450E4B8-3D5183D5 To: ;tag=as6eca219b Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="54f913e9" Content-Length: 0 --- Aug 29 11:22:16 VERBOSE[8578] logger.c: Scheduling destruction of call '8823106c-caf8f2d2-a87005af@10.1.1.200' in 15000 ms Aug 29 11:22:16 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8141c17b512461E From: "Wilson" ;tag=D450E4B8-3D5183D5 To: CSeq: 2 SUBSCRIBE Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="54f913e9", uri="sip:2000@10.1.1.48:5060", response="655cc18863eb01ef7b04e542f47022ec", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:16 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:16 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 8823106c-caf8f2d2-a87005af@10.1.1.200 Aug 29 11:22:16 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:16 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:16 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:16 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:16 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:16 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8141c17b512461E From: "Wilson" ;tag=D450E4B8-3D5183D5 To: ;tag=as5474feb9 Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:16 VERBOSE[8578] logger.c: Scheduling destruction of call '8823106c-caf8f2d2-a87005af@10.1.1.200' in 3610000 ms Aug 29 11:22:16 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK487cffff From: ;tag=as5474feb9 To: "Wilson" ;tag=D450E4B8-3D5183D5 Contact: Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:17 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK487cffff From: ;tag=as5474feb9 To: "Wilson" ;tag=D450E4B8-3D5183D5 CSeq: 102 NOTIFY Call-ID: 8823106c-caf8f2d2-a87005af@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:17 DEBUG[8578] chan_sip.c: Stopping retransmission on '8823106c-caf8f2d2-a87005af@10.1.1.200' of Request 102: Match Found Aug 29 11:22:17 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:17 VERBOSE[8578] logger.c: 11 headers, 3 lines Aug 29 11:22:17 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.200 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7a422fc0 From: "asterisk" ;tag=as19c7af1f To: Contact: Call-ID: 6ed5e8170a174cbd2cc89cb14dd3e8b9@10.1.1.48 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 80 Message-Account: sip:asterisk@ Messages-Waiting: no Voice-Message: 0/0 (0/0) --- Aug 29 11:22:17 VERBOSE[8578] logger.c: Scheduling destruction of call '6ed5e8170a174cbd2cc89cb14dd3e8b9@10.1.1.48' in 15000 ms Aug 29 11:22:17 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7a422fc0 From: "asterisk" ;tag=as19c7af1f To: ;tag=A85C7704-81841EA1 CSeq: 102 NOTIFY Call-ID: 6ed5e8170a174cbd2cc89cb14dd3e8b9@10.1.1.48 Contact: Event: message-summary User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:17 DEBUG[8578] chan_sip.c: Stopping retransmission on '6ed5e8170a174cbd2cc89cb14dd3e8b9@10.1.1.48' of Request 102: Match Found Aug 29 11:22:17 VERBOSE[8578] logger.c: Destroying call '6ed5e8170a174cbd2cc89cb14dd3e8b9@10.1.1.48' Aug 29 11:22:17 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK4893fb47F986D76A From: "Wilson" ;tag=43AE4E39-E7F1A6B6 To: CSeq: 1 SUBSCRIBE Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:17 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:17 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:17 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:17 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK4893fb47F986D76A From: "Wilson" ;tag=43AE4E39-E7F1A6B6 To: ;tag=as33423f85 Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="118175e2" Content-Length: 0 --- Aug 29 11:22:17 VERBOSE[8578] logger.c: Scheduling destruction of call 'a424b76d-6b21b313-aa20c750@10.1.1.200' in 15000 ms Aug 29 11:22:17 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKe2f8d59cE925E8DF From: "Wilson" ;tag=43AE4E39-E7F1A6B6 To: CSeq: 2 SUBSCRIBE Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="118175e2", uri="sip:1002@10.1.1.48:5060", response="8a28a5ea5a1ec3ca5e03a58e4d6f4ba2", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:17 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:17 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription a424b76d-6b21b313-aa20c750@10.1.1.200 Aug 29 11:22:17 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:17 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:17 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:17 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:17 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:17 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKe2f8d59cE925E8DF From: "Wilson" ;tag=43AE4E39-E7F1A6B6 To: ;tag=as23620c23 Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:17 VERBOSE[8578] logger.c: Scheduling destruction of call 'a424b76d-6b21b313-aa20c750@10.1.1.200' in 3610000 ms Aug 29 11:22:17 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1126a7f1 From: ;tag=as23620c23 To: "Wilson" ;tag=43AE4E39-E7F1A6B6 Contact: Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:18 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1126a7f1 From: ;tag=as23620c23 To: "Wilson" ;tag=43AE4E39-E7F1A6B6 CSeq: 102 NOTIFY Call-ID: a424b76d-6b21b313-aa20c750@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:18 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:18 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:18 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a424b76d-6b21b313-aa20c750@10.1.1.200' of Request 102: Match Found Aug 29 11:22:18 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:18 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKd36db402F21BE305 From: "Wilson" ;tag=90D02C34-F4E875D1 To: CSeq: 1 SUBSCRIBE Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:18 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:18 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:18 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:18 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:18 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:18 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKd36db402F21BE305 From: "Wilson" ;tag=90D02C34-F4E875D1 To: ;tag=as6474024b Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="69b85f3f" Content-Length: 0 --- Aug 29 11:22:18 VERBOSE[8578] logger.c: Scheduling destruction of call '7fbfa1e8-4295ff4e-165b9cab@10.1.1.200' in 15000 ms Aug 29 11:22:19 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK59fdce77FF85889A From: "Wilson" ;tag=90D02C34-F4E875D1 To: CSeq: 2 SUBSCRIBE Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="69b85f3f", uri="sip:2000@10.1.1.48:5060", response="9b24d2821357d4a9b7359c686296f0c9", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:19 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 Aug 29 11:22:19 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:19 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:19 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:19 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:19 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:19 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK59fdce77FF85889A From: "Wilson" ;tag=90D02C34-F4E875D1 To: ;tag=as73440252 Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:19 VERBOSE[8578] logger.c: Scheduling destruction of call '7fbfa1e8-4295ff4e-165b9cab@10.1.1.200' in 3610000 ms Aug 29 11:22:19 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0b6a741c From: ;tag=as73440252 To: "Wilson" ;tag=90D02C34-F4E875D1 Contact: Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:19 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0b6a741c From: ;tag=as73440252 To: "Wilson" ;tag=90D02C34-F4E875D1 CSeq: 102 NOTIFY Call-ID: 7fbfa1e8-4295ff4e-165b9cab@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:19 DEBUG[8578] chan_sip.c: Stopping retransmission on '7fbfa1e8-4295ff4e-165b9cab@10.1.1.200' of Request 102: Match Found Aug 29 11:22:19 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:19 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK50f069dCA057480 From: "Wilson" ;tag=A2F3AC0F-42BA7ACC To: CSeq: 1 SUBSCRIBE Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:19 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:19 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:19 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:19 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:19 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK50f069dCA057480 From: "Wilson" ;tag=A2F3AC0F-42BA7ACC To: ;tag=as1efb4fa5 Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="1765061c" Content-Length: 0 --- Aug 29 11:22:19 VERBOSE[8578] logger.c: Scheduling destruction of call 'eec77e43-f0a9569-d7d74fe6@10.1.1.200' in 15000 ms Aug 29 11:22:20 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5ca65532F2D62235 From: "Wilson" ;tag=A2F3AC0F-42BA7ACC To: CSeq: 2 SUBSCRIBE Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="1765061c", uri="sip:1002@10.1.1.48:5060", response="68ae09364bc802b6cee4c00074b61988", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:20 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription eec77e43-f0a9569-d7d74fe6@10.1.1.200 Aug 29 11:22:20 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:20 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:20 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:20 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:20 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:20 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5ca65532F2D62235 From: "Wilson" ;tag=A2F3AC0F-42BA7ACC To: ;tag=as10c69bb4 Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:20 VERBOSE[8578] logger.c: Scheduling destruction of call 'eec77e43-f0a9569-d7d74fe6@10.1.1.200' in 3610000 ms Aug 29 11:22:20 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK456f1cd0 From: ;tag=as10c69bb4 To: "Wilson" ;tag=A2F3AC0F-42BA7ACC Contact: Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:20 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK456f1cd0 From: ;tag=as10c69bb4 To: "Wilson" ;tag=A2F3AC0F-42BA7ACC CSeq: 102 NOTIFY Call-ID: eec77e43-f0a9569-d7d74fe6@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:20 DEBUG[8578] chan_sip.c: Stopping retransmission on 'eec77e43-f0a9569-d7d74fe6@10.1.1.200' of Request 102: Match Found Aug 29 11:22:20 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:20 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK35ca3f18983D57DB From: "Wilson" ;tag=1A819CA-3DF81A7 To: CSeq: 1 SUBSCRIBE Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:20 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:20 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:20 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:20 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:20 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK35ca3f18983D57DB From: "Wilson" ;tag=1A819CA-3DF81A7 To: ;tag=as55ce6349 Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="6b04ff78" Content-Length: 0 --- Aug 29 11:22:20 VERBOSE[8578] logger.c: Scheduling destruction of call 'a28d987e-c18fc164-43ecad01@10.1.1.200' in 15000 ms Aug 29 11:22:21 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK94935cdA7E601B0 From: "Wilson" ;tag=1A819CA-3DF81A7 To: CSeq: 2 SUBSCRIBE Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="6b04ff78", uri="sip:2000@10.1.1.48:5060", response="29982fd874d4fdad7433cf864d2eb9a8", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:21 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription a28d987e-c18fc164-43ecad01@10.1.1.200 Aug 29 11:22:21 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:21 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:21 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:21 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:21 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:21 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK94935cdA7E601B0 From: "Wilson" ;tag=1A819CA-3DF81A7 To: ;tag=as5aa7ed74 Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:21 VERBOSE[8578] logger.c: Scheduling destruction of call 'a28d987e-c18fc164-43ecad01@10.1.1.200' in 3610000 ms Aug 29 11:22:21 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0bd62a21 From: ;tag=as5aa7ed74 To: "Wilson" ;tag=1A819CA-3DF81A7 Contact: Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:21 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK0bd62a21 From: ;tag=as5aa7ed74 To: "Wilson" ;tag=1A819CA-3DF81A7 CSeq: 102 NOTIFY Call-ID: a28d987e-c18fc164-43ecad01@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:21 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a28d987e-c18fc164-43ecad01@10.1.1.200' of Request 102: Match Found Aug 29 11:22:21 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:21 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKee952973D590D916 From: "Wilson" ;tag=CE404165-3D62D662 To: CSeq: 1 SUBSCRIBE Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:21 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:21 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:21 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:21 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKee952973D590D916 From: "Wilson" ;tag=CE404165-3D62D662 To: ;tag=as52e7c3e1 Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="3999ef19" Content-Length: 0 --- Aug 29 11:22:21 VERBOSE[8578] logger.c: Scheduling destruction of call '7d66bc99-f4994f3f-e27fffc@10.1.1.200' in 15000 ms Aug 29 11:22:21 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK3d30bc485A6F30B From: "Wilson" ;tag=CE404165-3D62D662 To: CSeq: 2 SUBSCRIBE Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="3999ef19", uri="sip:1002@10.1.1.48:5060", response="874cda6e35b9e785f21d4fc19e8d0cbb", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:21 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:21 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 7d66bc99-f4994f3f-e27fffc@10.1.1.200 Aug 29 11:22:21 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:21 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:21 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:21 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:21 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:21 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK3d30bc485A6F30B From: "Wilson" ;tag=CE404165-3D62D662 To: ;tag=as51a95a90 Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:21 VERBOSE[8578] logger.c: Scheduling destruction of call '7d66bc99-f4994f3f-e27fffc@10.1.1.200' in 3610000 ms Aug 29 11:22:21 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3c20903e From: ;tag=as51a95a90 To: "Wilson" ;tag=CE404165-3D62D662 Contact: Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:22 DEBUG[8578] chan_sip.c: Auto destroying call '6d7d4efe-a9df97e4-97477381@10.1.1.200' Aug 29 11:22:22 VERBOSE[8578] logger.c: Destroying call '6d7d4efe-a9df97e4-97477381@10.1.1.200' Aug 29 11:22:22 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3c20903e From: ;tag=as51a95a90 To: "Wilson" ;tag=CE404165-3D62D662 CSeq: 102 NOTIFY Call-ID: 7d66bc99-f4994f3f-e27fffc@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:22 DEBUG[8578] chan_sip.c: Stopping retransmission on '7d66bc99-f4994f3f-e27fffc@10.1.1.200' of Request 102: Match Found Aug 29 11:22:22 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:22 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKdbb911aeDD50C431 From: "Wilson" ;tag=4A826EE0-FF9344FD To: CSeq: 1 SUBSCRIBE Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:22 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:22 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:22 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:22 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKdbb911aeDD50C431 From: "Wilson" ;tag=4A826EE0-FF9344FD To: ;tag=as3a38baa0 Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="4305aa29" Content-Length: 0 --- Aug 29 11:22:22 VERBOSE[8578] logger.c: Scheduling destruction of call '615b3694-96ae8afa-24f914d7@10.1.1.200' in 15000 ms Aug 29 11:22:22 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK294ab4a357DE4246 From: "Wilson" ;tag=4A826EE0-FF9344FD To: CSeq: 2 SUBSCRIBE Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="4305aa29", uri="sip:2000@10.1.1.48:5060", response="83103939bf0eb4bfafe1010f4e9af02d", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:22 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:22 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 615b3694-96ae8afa-24f914d7@10.1.1.200 Aug 29 11:22:22 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:22 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:22 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:22 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:22 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:22 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK294ab4a357DE4246 From: "Wilson" ;tag=4A826EE0-FF9344FD To: ;tag=as05567af4 Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:22 VERBOSE[8578] logger.c: Scheduling destruction of call '615b3694-96ae8afa-24f914d7@10.1.1.200' in 3610000 ms Aug 29 11:22:22 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1c4b04ea From: ;tag=as05567af4 To: "Wilson" ;tag=4A826EE0-FF9344FD Contact: Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:23 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1c4b04ea From: ;tag=as05567af4 To: "Wilson" ;tag=4A826EE0-FF9344FD CSeq: 102 NOTIFY Call-ID: 615b3694-96ae8afa-24f914d7@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:23 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:23 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:23 DEBUG[8578] chan_sip.c: Stopping retransmission on '615b3694-96ae8afa-24f914d7@10.1.1.200' of Request 102: Match Found Aug 29 11:22:23 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:23 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKbd82c3c92C01652C From: "Wilson" ;tag=DD586E3B-5CB31978 To: CSeq: 1 SUBSCRIBE Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:23 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:23 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:23 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:23 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:23 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:23 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKbd82c3c92C01652C From: "Wilson" ;tag=DD586E3B-5CB31978 To: ;tag=as1ccaa32b Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="6886e6db" Content-Length: 0 --- Aug 29 11:22:23 VERBOSE[8578] logger.c: Scheduling destruction of call '7cd6d26f-931a4095-cc633792@10.1.1.200' in 15000 ms Aug 29 11:22:24 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK24d86adeAFD4BB61 From: "Wilson" ;tag=DD586E3B-5CB31978 To: CSeq: 2 SUBSCRIBE Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="6886e6db", uri="sip:1002@10.1.1.48:5060", response="0c8558ca025e6c72dcdbb885107b5580", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:24 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 7cd6d26f-931a4095-cc633792@10.1.1.200 Aug 29 11:22:24 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:24 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:24 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:24 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:24 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK24d86adeAFD4BB61 From: "Wilson" ;tag=DD586E3B-5CB31978 To: ;tag=as0172f2e0 Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: Scheduling destruction of call '7cd6d26f-931a4095-cc633792@10.1.1.200' in 3610000 ms Aug 29 11:22:24 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK50f053a5 From: ;tag=as0172f2e0 To: "Wilson" ;tag=DD586E3B-5CB31978 Contact: Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:24 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK50f053a5 From: ;tag=as0172f2e0 To: "Wilson" ;tag=DD586E3B-5CB31978 CSeq: 102 NOTIFY Call-ID: 7cd6d26f-931a4095-cc633792@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:24 DEBUG[8578] chan_sip.c: Stopping retransmission on '7cd6d26f-931a4095-cc633792@10.1.1.200' of Request 102: Match Found Aug 29 11:22:24 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:24 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKbaa3f8ee4B5D718D From: "Scott" ;tag=CA7417C-35D4AA61 To: CSeq: 1 REGISTER Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (11 headers 0 lines)Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (11 headers 0 lines)--- Aug 29 11:22:24 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:22:24 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKbaa3f8ee4B5D718D From: "Scott" ;tag=CA7417C-35D4AA61 To: Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 CSeq: 1 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKbaa3f8ee4B5D718D From: "Scott" ;tag=CA7417C-35D4AA61 To: ;tag=as5b2f8f91 Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 CSeq: 1 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="68c3cb1f" Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: Scheduling destruction of call '4ee64e18-22d45572-a16972ff@10.1.1.201' in 15000 ms Aug 29 11:22:24 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: REGISTER sip:10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd3c57c3320C390B6 From: "Scott" ;tag=CA7417C-35D4AA61 To: CSeq: 2 REGISTER Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 Contact: ;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER" User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="68c3cb1f", uri="sip:10.1.1.48:5060", response="ca3e3fe670916aa6020d727db591ccdf", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (12 headers 0 lines)Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (12 headers 0 lines)--- Aug 29 11:22:24 VERBOSE[8578] logger.c: Using latest request as basis request Aug 29 11:22:24 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd3c57c3320C390B6 From: "Scott" ;tag=CA7417C-35D4AA61 To: Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 CSeq: 2 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: -- Saved useragent "PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054" for peer scott-polycom Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd3c57c3320C390B6 From: "Scott" ;tag=CA7417C-35D4AA61 To: ;tag=as5b2f8f91 Call-ID: 4ee64e18-22d45572-a16972ff@10.1.1.201 CSeq: 2 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Date: Mon, 29 Aug 2005 18:22:24 GMT Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: Scheduling destruction of call '4ee64e18-22d45572-a16972ff@10.1.1.201' in 15000 ms Aug 29 11:22:24 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK16f28bc41C0A8807 From: "Wilson" ;tag=557F8B76-DDA81FD3 To: CSeq: 1 SUBSCRIBE Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:24 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:24 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:24 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:24 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:24 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK16f28bc41C0A8807 From: "Wilson" ;tag=557F8B76-DDA81FD3 To: ;tag=as6478f7d4 Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="6435f07a" Content-Length: 0 --- Aug 29 11:22:24 VERBOSE[8578] logger.c: Scheduling destruction of call 'd558dc2a-389abc10-b6ad342d@10.1.1.200' in 15000 ms Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK7e1eaaf9306AA5C From: "Wilson" ;tag=557F8B76-DDA81FD3 To: CSeq: 2 SUBSCRIBE Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="6435f07a", uri="sip:2000@10.1.1.48:5060", response="13ec70f74e2979f964ef0c2171d46cee", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription d558dc2a-389abc10-b6ad342d@10.1.1.200 Aug 29 11:22:25 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:25 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:25 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:25 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:25 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK7e1eaaf9306AA5C From: "Wilson" ;tag=557F8B76-DDA81FD3 To: ;tag=as6e609956 Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:25 VERBOSE[8578] logger.c: Scheduling destruction of call 'd558dc2a-389abc10-b6ad342d@10.1.1.200' in 3610000 ms Aug 29 11:22:25 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK20fad9d9 From: ;tag=as6e609956 To: "Wilson" ;tag=557F8B76-DDA81FD3 Contact: Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK20fad9d9 From: ;tag=as6e609956 To: "Wilson" ;tag=557F8B76-DDA81FD3 CSeq: 102 NOTIFY Call-ID: d558dc2a-389abc10-b6ad342d@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd558dc2a-389abc10-b6ad342d@10.1.1.200' of Request 102: Match Found Aug 29 11:22:25 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKa3b588f59D9FADA0 From: "Scott" ;tag=F8FC79DB-ABEF5684 To: CSeq: 1 SUBSCRIBE Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:25 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:25 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:25 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:25 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKa3b588f59D9FADA0 From: "Scott" ;tag=F8FC79DB-ABEF5684 To: ;tag=as193c5cc0 Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="6935444e" Content-Length: 0 --- Aug 29 11:22:25 VERBOSE[8578] logger.c: Scheduling destruction of call '5faccd27-ccbbc149-c52d8eba@10.1.1.201' in 15000 ms Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd29ef37eE922C75D From: "Scott" ;tag=F8FC79DB-ABEF5684 To: CSeq: 2 SUBSCRIBE Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="6935444e", uri="sip:1002@10.1.1.48:5060", response="9f7e555acc8d97a9bc4bbe78fe14108c", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 5faccd27-ccbbc149-c52d8eba@10.1.1.201 Aug 29 11:22:25 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:25 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:25 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:25 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer scott-polycom Aug 29 11:22:25 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd29ef37eE922C75D From: "Scott" ;tag=F8FC79DB-ABEF5684 To: ;tag=as0533042e Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:25 VERBOSE[8578] logger.c: Scheduling destruction of call '5faccd27-ccbbc149-c52d8eba@10.1.1.201' in 3610000 ms Aug 29 11:22:25 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3cb6f19d From: ;tag=as0533042e To: "Scott" ;tag=F8FC79DB-ABEF5684 Contact: Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3cb6f19d From: ;tag=as0533042e To: "Scott" ;tag=F8FC79DB-ABEF5684 CSeq: 102 NOTIFY Call-ID: 5faccd27-ccbbc149-c52d8eba@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:25 DEBUG[8578] chan_sip.c: Stopping retransmission on '5faccd27-ccbbc149-c52d8eba@10.1.1.201' of Request 102: Match Found Aug 29 11:22:25 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:25 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5a6c359fE06778C2 From: "Wilson" ;tag=2A389291-34ABA40E To: CSeq: 1 SUBSCRIBE Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:25 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:25 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:25 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:25 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:25 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5a6c359fE06778C2 From: "Wilson" ;tag=2A389291-34ABA40E To: ;tag=as06c122fa Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="5bba36e3" Content-Length: 0 --- Aug 29 11:22:25 VERBOSE[8578] logger.c: Scheduling destruction of call 'd0241fc5-1e11c96b-db1156a8@10.1.1.200' in 15000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK915c0f4C7D3DB37 From: "Wilson" ;tag=2A389291-34ABA40E To: CSeq: 2 SUBSCRIBE Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="5bba36e3", uri="sip:1002@10.1.1.48:5060", response="3e99c6619c3477cbefe4bbdf419622a9", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription d0241fc5-1e11c96b-db1156a8@10.1.1.200 Aug 29 11:22:26 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:26 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:26 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:26 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:26 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK915c0f4C7D3DB37 From: "Wilson" ;tag=2A389291-34ABA40E To: ;tag=as302f359c Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:26 VERBOSE[8578] logger.c: Scheduling destruction of call 'd0241fc5-1e11c96b-db1156a8@10.1.1.200' in 3610000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1cd925b0 From: ;tag=as302f359c To: "Wilson" ;tag=2A389291-34ABA40E Contact: Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK1cd925b0 From: ;tag=as302f359c To: "Wilson" ;tag=2A389291-34ABA40E CSeq: 102 NOTIFY Call-ID: d0241fc5-1e11c96b-db1156a8@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd0241fc5-1e11c96b-db1156a8@10.1.1.200' of Request 102: Match Found Aug 29 11:22:26 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd610c0287E63564F From: "Scott" ;tag=18364146-EF55F683 To: CSeq: 1 SUBSCRIBE Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:26 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:26 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:26 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:26 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKd610c0287E63564F From: "Scott" ;tag=18364146-EF55F683 To: ;tag=as1f3803ce Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="2b671f2a" Content-Length: 0 --- Aug 29 11:22:26 VERBOSE[8578] logger.c: Scheduling destruction of call 'd1b92302-ebfd2e8c-5d39cf31@10.1.1.201' in 15000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK2eb7ccc51910A5B0 From: "Scott" ;tag=18364146-EF55F683 To: CSeq: 2 SUBSCRIBE Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="2b671f2a", uri="sip:3000@10.1.1.48:5060", response="12212c93c5c716d6468dfaed55829dcd", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 Aug 29 11:22:26 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:26 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:26 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:26 VERBOSE[8578] logger.c: Looking for 3000 in from-sip Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Adding subscription for extension 3000 context from-sip for peer scott-polycom Aug 29 11:22:26 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK2eb7ccc51910A5B0 From: "Scott" ;tag=18364146-EF55F683 To: ;tag=as2c4738fd Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:26 VERBOSE[8578] logger.c: Scheduling destruction of call 'd1b92302-ebfd2e8c-5d39cf31@10.1.1.201' in 3610000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6b9f9d80 From: ;tag=as2c4738fd To: "Scott" ;tag=18364146-EF55F683 Contact: Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6b9f9d80 From: ;tag=as2c4738fd To: "Scott" ;tag=18364146-EF55F683 CSeq: 102 NOTIFY Call-ID: d1b92302-ebfd2e8c-5d39cf31@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd1b92302-ebfd2e8c-5d39cf31@10.1.1.201' of Request 102: Match Found Aug 29 11:22:26 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK54670d5a7D57035D From: "Wilson" ;tag=79F7CF8C-EDFA7229 To: CSeq: 1 SUBSCRIBE Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:26 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:26 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:26 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:26 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK54670d5a7D57035D From: "Wilson" ;tag=79F7CF8C-EDFA7229 To: ;tag=as13b8b7a5 Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="1dd00462" Content-Length: 0 --- Aug 29 11:22:26 VERBOSE[8578] logger.c: Scheduling destruction of call '78eee940-4534b4a6-ca6d6b03@10.1.1.200' in 15000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK2c1978cfD02F99F2 From: "Wilson" ;tag=79F7CF8C-EDFA7229 To: CSeq: 2 SUBSCRIBE Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="1dd00462", uri="sip:2000@10.1.1.48:5060", response="66a68b5d7185541749d466071486f34b", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:26 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 78eee940-4534b4a6-ca6d6b03@10.1.1.200 Aug 29 11:22:26 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:26 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:26 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:26 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:26 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:26 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK2c1978cfD02F99F2 From: "Wilson" ;tag=79F7CF8C-EDFA7229 To: ;tag=as4a98a113 Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:26 VERBOSE[8578] logger.c: Scheduling destruction of call '78eee940-4534b4a6-ca6d6b03@10.1.1.200' in 3610000 ms Aug 29 11:22:26 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3c8e4641 From: ;tag=as4a98a113 To: "Wilson" ;tag=79F7CF8C-EDFA7229 Contact: Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3c8e4641 From: ;tag=as4a98a113 To: "Wilson" ;tag=79F7CF8C-EDFA7229 CSeq: 102 NOTIFY Call-ID: 78eee940-4534b4a6-ca6d6b03@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Stopping retransmission on '78eee940-4534b4a6-ca6d6b03@10.1.1.200' of Request 102: Match Found Aug 29 11:22:27 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:27 VERBOSE[8578] logger.c: 11 headers, 3 lines Aug 29 11:22:27 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.201 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK50cdbc78 From: "asterisk" ;tag=as040ffbfd To: Contact: Call-ID: 4673fb37302c5a7623705cc8181eee5c@10.1.1.48 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 80 Message-Account: sip:asterisk@ Messages-Waiting: no Voice-Message: 0/0 (0/0) --- Aug 29 11:22:27 VERBOSE[8578] logger.c: Scheduling destruction of call '4673fb37302c5a7623705cc8181eee5c@10.1.1.48' in 15000 ms Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK2dc2ae7766AD324A From: "Scott" ;tag=4C03392D-81159A0E To: CSeq: 1 SUBSCRIBE Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:27 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:27 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:27 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:27 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK2dc2ae7766AD324A From: "Scott" ;tag=4C03392D-81159A0E To: ;tag=as524fc836 Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="69b4ce52" Content-Length: 0 --- Aug 29 11:22:27 VERBOSE[8578] logger.c: Scheduling destruction of call '37cf7419-5f85922b-7eade994@10.1.1.201' in 15000 ms Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK50cdbc78 From: "asterisk" ;tag=as040ffbfd To: ;tag=839C759F-83A27E38 CSeq: 102 NOTIFY Call-ID: 4673fb37302c5a7623705cc8181eee5c@10.1.1.48 Contact: Event: message-summary User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Stopping retransmission on '4673fb37302c5a7623705cc8181eee5c@10.1.1.48' of Request 102: Match Found Aug 29 11:22:27 VERBOSE[8578] logger.c: Destroying call '4673fb37302c5a7623705cc8181eee5c@10.1.1.48' Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKe60bdc9242B95001 From: "Scott" ;tag=4C03392D-81159A0E To: CSeq: 2 SUBSCRIBE Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="69b4ce52", uri="sip:1002@10.1.1.48:5060", response="aa3fbe60d1d314ef22ea67792998ebb0", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 37cf7419-5f85922b-7eade994@10.1.1.201 Aug 29 11:22:27 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:27 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:27 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:27 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer scott-polycom Aug 29 11:22:27 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKe60bdc9242B95001 From: "Scott" ;tag=4C03392D-81159A0E To: ;tag=as7a7b6a06 Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:27 VERBOSE[8578] logger.c: Scheduling destruction of call '37cf7419-5f85922b-7eade994@10.1.1.201' in 3610000 ms Aug 29 11:22:27 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6b82787a From: ;tag=as7a7b6a06 To: "Scott" ;tag=4C03392D-81159A0E Contact: Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK6b82787a From: ;tag=as7a7b6a06 To: "Scott" ;tag=4C03392D-81159A0E CSeq: 102 NOTIFY Call-ID: 37cf7419-5f85922b-7eade994@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Stopping retransmission on '37cf7419-5f85922b-7eade994@10.1.1.201' of Request 102: Match Found Aug 29 11:22:27 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK941ddef57F0B73D8 From: "Wilson" ;tag=87150E67-DE84D624 To: CSeq: 1 SUBSCRIBE Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:27 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:27 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:27 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:27 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK941ddef57F0B73D8 From: "Wilson" ;tag=87150E67-DE84D624 To: ;tag=as1019316d Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="7b1e30e5" Content-Length: 0 --- Aug 29 11:22:27 VERBOSE[8578] logger.c: Scheduling destruction of call '4693049b-3b3c49c1-41f2bd3e@10.1.1.200' in 15000 ms Aug 29 11:22:27 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK2a991e8a2250B28D From: "Wilson" ;tag=87150E67-DE84D624 To: CSeq: 2 SUBSCRIBE Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="7b1e30e5", uri="sip:1002@10.1.1.48:5060", response="40aa494efa4dbbf5aae6a185f22446eb", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:27 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 Aug 29 11:22:27 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:27 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:27 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:27 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:27 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:27 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK2a991e8a2250B28D From: "Wilson" ;tag=87150E67-DE84D624 To: ;tag=as55c61e59 Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:27 VERBOSE[8578] logger.c: Scheduling destruction of call '4693049b-3b3c49c1-41f2bd3e@10.1.1.200' in 3610000 ms Aug 29 11:22:27 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7a23cb51 From: ;tag=as55c61e59 To: "Wilson" ;tag=87150E67-DE84D624 Contact: Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:28 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7a23cb51 From: ;tag=as55c61e59 To: "Wilson" ;tag=87150E67-DE84D624 CSeq: 102 NOTIFY Call-ID: 4693049b-3b3c49c1-41f2bd3e@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:28 DEBUG[8578] chan_sip.c: Stopping retransmission on '4693049b-3b3c49c1-41f2bd3e@10.1.1.200' of Request 102: Match Found Aug 29 11:22:28 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:28 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKdc4aa79c8F1AECD3 From: "Scott" ;tag=322341DA-25DE4BC7 To: CSeq: 1 SUBSCRIBE Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:28 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:28 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:28 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:28 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKdc4aa79c8F1AECD3 From: "Scott" ;tag=322341DA-25DE4BC7 To: ;tag=as729835ca Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="2c3224e3" Content-Length: 0 --- Aug 29 11:22:28 VERBOSE[8578] logger.c: Scheduling destruction of call '88d51dd6-f7569c0-9b8fac95@10.1.1.201' in 15000 ms Aug 29 11:22:28 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK307002e9FC0888A4 From: "Scott" ;tag=322341DA-25DE4BC7 To: CSeq: 2 SUBSCRIBE Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="2c3224e3", uri="sip:3000@10.1.1.48:5060", response="da736edba578ca95284190eb08a7dcf2", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:28 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 88d51dd6-f7569c0-9b8fac95@10.1.1.201 Aug 29 11:22:28 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:28 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:28 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:28 VERBOSE[8578] logger.c: Looking for 3000 in from-sip Aug 29 11:22:28 DEBUG[8578] chan_sip.c: Adding subscription for extension 3000 context from-sip for peer scott-polycom Aug 29 11:22:28 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK307002e9FC0888A4 From: "Scott" ;tag=322341DA-25DE4BC7 To: ;tag=as7ddb7f74 Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:28 VERBOSE[8578] logger.c: Scheduling destruction of call '88d51dd6-f7569c0-9b8fac95@10.1.1.201' in 3610000 ms Aug 29 11:22:28 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7ef30a54 From: ;tag=as7ddb7f74 To: "Scott" ;tag=322341DA-25DE4BC7 Contact: Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:28 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7ef30a54 From: ;tag=as7ddb7f74 To: "Scott" ;tag=322341DA-25DE4BC7 CSeq: 102 NOTIFY Call-ID: 88d51dd6-f7569c0-9b8fac95@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:28 DEBUG[8578] chan_sip.c: Stopping retransmission on '88d51dd6-f7569c0-9b8fac95@10.1.1.201' of Request 102: Match Found Aug 29 11:22:28 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:28 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK923ef6702E5A9633 From: "Wilson" ;tag=727B9B22-109E9BFF To: CSeq: 1 SUBSCRIBE Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:28 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:28 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:28 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:28 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:28 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK923ef6702E5A9633 From: "Wilson" ;tag=727B9B22-109E9BFF To: ;tag=as7356d17d Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="365c7ba7" Content-Length: 0 --- Aug 29 11:22:28 VERBOSE[8578] logger.c: Scheduling destruction of call '1dbdbdd6-f794d4bc-bbd61959@10.1.1.200' in 15000 ms Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6dc77e258F617108 From: "Wilson" ;tag=727B9B22-109E9BFF To: CSeq: 2 SUBSCRIBE Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="365c7ba7", uri="sip:2000@10.1.1.48:5060", response="5ed94f61552de900618349da80a1fe8e", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 Aug 29 11:22:29 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:29 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:29 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:29 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:29 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK6dc77e258F617108 From: "Wilson" ;tag=727B9B22-109E9BFF To: ;tag=as3bb2f69b Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:29 VERBOSE[8578] logger.c: Scheduling destruction of call '1dbdbdd6-f794d4bc-bbd61959@10.1.1.200' in 3610000 ms Aug 29 11:22:29 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3e5a80b8 From: ;tag=as3bb2f69b To: "Wilson" ;tag=727B9B22-109E9BFF Contact: Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK3e5a80b8 From: ;tag=as3bb2f69b To: "Wilson" ;tag=727B9B22-109E9BFF CSeq: 102 NOTIFY Call-ID: 1dbdbdd6-f794d4bc-bbd61959@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Stopping retransmission on '1dbdbdd6-f794d4bc-bbd61959@10.1.1.200' of Request 102: Match Found Aug 29 11:22:29 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKc301a67bEB98EC9E From: "Scott" ;tag=26282CD1-9A0D8222 To: CSeq: 1 SUBSCRIBE Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:29 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:29 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:29 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:29 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKc301a67bEB98EC9E From: "Scott" ;tag=26282CD1-9A0D8222 To: ;tag=as615c4597 Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="49e32c72" Content-Length: 0 --- Aug 29 11:22:29 VERBOSE[8578] logger.c: Scheduling destruction of call '2963c6fd-e511d0ef-a3648848@10.1.1.201' in 15000 ms Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK3c88acac92015F23 From: "Scott" ;tag=26282CD1-9A0D8222 To: CSeq: 2 SUBSCRIBE Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="49e32c72", uri="sip:1002@10.1.1.48:5060", response="fae0b2d0f97ae0a2ab7f3d5931eab9bd", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 2963c6fd-e511d0ef-a3648848@10.1.1.201 Aug 29 11:22:29 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:29 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:29 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:29 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer scott-polycom Aug 29 11:22:29 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK3c88acac92015F23 From: "Scott" ;tag=26282CD1-9A0D8222 To: ;tag=as4b561f53 Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:29 VERBOSE[8578] logger.c: Scheduling destruction of call '2963c6fd-e511d0ef-a3648848@10.1.1.201' in 3610000 ms Aug 29 11:22:29 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7d82dc9d From: ;tag=as4b561f53 To: "Scott" ;tag=26282CD1-9A0D8222 Contact: Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK7d82dc9d From: ;tag=as4b561f53 To: "Scott" ;tag=26282CD1-9A0D8222 CSeq: 102 NOTIFY Call-ID: 2963c6fd-e511d0ef-a3648848@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:29 DEBUG[8578] chan_sip.c: Stopping retransmission on '2963c6fd-e511d0ef-a3648848@10.1.1.201' of Request 102: Match Found Aug 29 11:22:29 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:29 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK559c1fcb36DB66E From: "Wilson" ;tag=F45A41BD-EEAF0FBA To: CSeq: 1 SUBSCRIBE Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:29 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:29 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:29 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:29 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:29 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK559c1fcb36DB66E From: "Wilson" ;tag=F45A41BD-EEAF0FBA To: ;tag=as1aa0042e Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="0363cf4d" Content-Length: 0 --- Aug 29 11:22:29 VERBOSE[8578] logger.c: Scheduling destruction of call '519fe0f1-388e2197-bdffcb54@10.1.1.200' in 15000 ms Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8b4ae3a0C82FA163 From: "Wilson" ;tag=F45A41BD-EEAF0FBA To: CSeq: 2 SUBSCRIBE Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="0363cf4d", uri="sip:1002@10.1.1.48:5060", response="f2f300b8dbe677595d485697baa4e142", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 519fe0f1-388e2197-bdffcb54@10.1.1.200 Aug 29 11:22:30 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:30 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:30 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:30 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:30 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK8b4ae3a0C82FA163 From: "Wilson" ;tag=F45A41BD-EEAF0FBA To: ;tag=as1400ee5e Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:30 VERBOSE[8578] logger.c: Scheduling destruction of call '519fe0f1-388e2197-bdffcb54@10.1.1.200' in 3610000 ms Aug 29 11:22:30 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK470992af From: ;tag=as1400ee5e To: "Wilson" ;tag=F45A41BD-EEAF0FBA Contact: Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK470992af From: ;tag=as1400ee5e To: "Wilson" ;tag=F45A41BD-EEAF0FBA CSeq: 102 NOTIFY Call-ID: 519fe0f1-388e2197-bdffcb54@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Stopping retransmission on '519fe0f1-388e2197-bdffcb54@10.1.1.200' of Request 102: Match Found Aug 29 11:22:30 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKaa91266651822865 From: "Scott" ;tag=7C5833B4-D2526DB9 To: CSeq: 1 SUBSCRIBE Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:30 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:30 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:30 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:30 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKaa91266651822865 From: "Scott" ;tag=7C5833B4-D2526DB9 To: ;tag=as4b107003 Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="7b7836cc" Content-Length: 0 --- Aug 29 11:22:30 VERBOSE[8578] logger.c: Scheduling destruction of call '53f6f9d0-7630bd6a-46dca517@10.1.1.201' in 15000 ms Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK273db6cbC079EB2E From: "Scott" ;tag=7C5833B4-D2526DB9 To: CSeq: 2 SUBSCRIBE Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="7b7836cc", uri="sip:3000@10.1.1.48:5060", response="392c12c04c17a7a618f62758fb19a938", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 53f6f9d0-7630bd6a-46dca517@10.1.1.201 Aug 29 11:22:30 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:30 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:30 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:30 VERBOSE[8578] logger.c: Looking for 3000 in from-sip Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Adding subscription for extension 3000 context from-sip for peer scott-polycom Aug 29 11:22:30 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK273db6cbC079EB2E From: "Scott" ;tag=7C5833B4-D2526DB9 To: ;tag=as353a37fc Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:30 VERBOSE[8578] logger.c: Scheduling destruction of call '53f6f9d0-7630bd6a-46dca517@10.1.1.201' in 3610000 ms Aug 29 11:22:30 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK12d94211 From: ;tag=as353a37fc To: "Scott" ;tag=7C5833B4-D2526DB9 Contact: Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK12d94211 From: ;tag=as353a37fc To: "Scott" ;tag=7C5833B4-D2526DB9 CSeq: 102 NOTIFY Call-ID: 53f6f9d0-7630bd6a-46dca517@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:30 DEBUG[8578] chan_sip.c: Stopping retransmission on '53f6f9d0-7630bd6a-46dca517@10.1.1.201' of Request 102: Match Found Aug 29 11:22:30 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:30 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK55daa7061671A089 From: "Wilson" ;tag=D2D34E38-6BE0FD55 To: CSeq: 1 SUBSCRIBE Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:30 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:30 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:30 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:30 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:30 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK55daa7061671A089 From: "Wilson" ;tag=D2D34E38-6BE0FD55 To: ;tag=as3cdedd39 Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="4253cdeb" Content-Length: 0 --- Aug 29 11:22:30 VERBOSE[8578] logger.c: Scheduling destruction of call '629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200' in 15000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc9ed1afbAFDC8F9E From: "Wilson" ;tag=D2D34E38-6BE0FD55 To: CSeq: 2 SUBSCRIBE Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="4253cdeb", uri="sip:2000@10.1.1.48:5060", response="3bfb934a3c098aa8a0645e23977f9595", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 Aug 29 11:22:31 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:31 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:31 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:31 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:31 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc9ed1afbAFDC8F9E From: "Wilson" ;tag=D2D34E38-6BE0FD55 To: ;tag=as5a4acf4b Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:31 VERBOSE[8578] logger.c: Scheduling destruction of call '629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200' in 3610000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK56a02b4e From: ;tag=as5a4acf4b To: "Wilson" ;tag=D2D34E38-6BE0FD55 Contact: Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK56a02b4e From: ;tag=as5a4acf4b To: "Wilson" ;tag=D2D34E38-6BE0FD55 CSeq: 102 NOTIFY Call-ID: 629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Stopping retransmission on '629db9ec-1e0b7c52-a6bb9f2f@10.1.1.200' of Request 102: Match Found Aug 29 11:22:31 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKce6970cdD3DFDE58 From: "Scott" ;tag=74B64D73-62703DBC To: CSeq: 1 SUBSCRIBE Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:31 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:31 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:31 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:31 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKce6970cdD3DFDE58 From: "Scott" ;tag=74B64D73-62703DBC To: ;tag=as6cf55ec5 Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="782383b4" Content-Length: 0 --- Aug 29 11:22:31 VERBOSE[8578] logger.c: Scheduling destruction of call '80683f-f31b65a1-74bf13b2@10.1.1.201' in 15000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK861b5af637944035 From: "Scott" ;tag=74B64D73-62703DBC To: CSeq: 2 SUBSCRIBE Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="782383b4", uri="sip:1002@10.1.1.48:5060", response="f5c827fc0f3a7847e6f8c437faec6389", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 80683f-f31b65a1-74bf13b2@10.1.1.201 Aug 29 11:22:31 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:31 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:31 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:31 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer scott-polycom Aug 29 11:22:31 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK861b5af637944035 From: "Scott" ;tag=74B64D73-62703DBC To: ;tag=as7d93d864 Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:31 VERBOSE[8578] logger.c: Scheduling destruction of call '80683f-f31b65a1-74bf13b2@10.1.1.201' in 3610000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK200df51b From: ;tag=as7d93d864 To: "Scott" ;tag=74B64D73-62703DBC Contact: Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK200df51b From: ;tag=as7d93d864 To: "Scott" ;tag=74B64D73-62703DBC CSeq: 102 NOTIFY Call-ID: 80683f-f31b65a1-74bf13b2@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Stopping retransmission on '80683f-f31b65a1-74bf13b2@10.1.1.201' of Request 102: Match Found Aug 29 11:22:31 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5c2358214E46A084 From: "Wilson" ;tag=D6AC8C93-EAD2B0D0 To: CSeq: 1 SUBSCRIBE Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:31 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:31 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:31 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:31 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK5c2358214E46A084 From: "Wilson" ;tag=D6AC8C93-EAD2B0D0 To: ;tag=as747a345a Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="6369fd89" Content-Length: 0 --- Aug 29 11:22:31 VERBOSE[8578] logger.c: Scheduling destruction of call '3aff14c7-c233b0ed-b768e0ea@10.1.1.200' in 15000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKe44b7036AC8D07B9 From: "Wilson" ;tag=D6AC8C93-EAD2B0D0 To: CSeq: 2 SUBSCRIBE Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="6369fd89", uri="sip:1002@10.1.1.48:5060", response="d0726a7dc0924a4e4151a489c3a8a6db", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:31 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 Aug 29 11:22:31 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:31 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:31 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:31 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:31 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer wilson-polycom Aug 29 11:22:31 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKe44b7036AC8D07B9 From: "Wilson" ;tag=D6AC8C93-EAD2B0D0 To: ;tag=as084ccd17 Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:31 VERBOSE[8578] logger.c: Scheduling destruction of call '3aff14c7-c233b0ed-b768e0ea@10.1.1.200' in 3610000 ms Aug 29 11:22:31 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK54377fe1 From: ;tag=as084ccd17 To: "Wilson" ;tag=D6AC8C93-EAD2B0D0 Contact: Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK54377fe1 From: ;tag=as084ccd17 To: "Wilson" ;tag=D6AC8C93-EAD2B0D0 CSeq: 102 NOTIFY Call-ID: 3aff14c7-c233b0ed-b768e0ea@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Stopping retransmission on '3aff14c7-c233b0ed-b768e0ea@10.1.1.200' of Request 102: Match Found Aug 29 11:22:32 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK147e55e0615ABA67 From: "Scott" ;tag=C6C995BE-55C6C31B To: CSeq: 1 SUBSCRIBE Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:32 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:32 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:32 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:32 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bK147e55e0615ABA67 From: "Scott" ;tag=C6C995BE-55C6C31B To: ;tag=as046e2a31 Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="1cdab3fe" Content-Length: 0 --- Aug 29 11:22:32 VERBOSE[8578] logger.c: Scheduling destruction of call '9636a4fa-d6b5eac4-4cebb489@10.1.1.201' in 15000 ms Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:3000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKeff9369d165D8068 From: "Scott" ;tag=C6C995BE-55C6C31B To: CSeq: 2 SUBSCRIBE Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="1cdab3fe", uri="sip:3000@10.1.1.48:5060", response="b42f925d8eedc823fc820c265f69d919", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 Aug 29 11:22:32 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:32 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:32 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:32 VERBOSE[8578] logger.c: Looking for 3000 in from-sip Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Adding subscription for extension 3000 context from-sip for peer scott-polycom Aug 29 11:22:32 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKeff9369d165D8068 From: "Scott" ;tag=C6C995BE-55C6C31B To: ;tag=as6da87076 Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:32 VERBOSE[8578] logger.c: Scheduling destruction of call '9636a4fa-d6b5eac4-4cebb489@10.1.1.201' in 3610000 ms Aug 29 11:22:32 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK486de56d From: ;tag=as6da87076 To: "Scott" ;tag=C6C995BE-55C6C31B Contact: Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK486de56d From: ;tag=as6da87076 To: "Scott" ;tag=C6C995BE-55C6C31B CSeq: 102 NOTIFY Call-ID: 9636a4fa-d6b5eac4-4cebb489@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Stopping retransmission on '9636a4fa-d6b5eac4-4cebb489@10.1.1.201' of Request 102: Match Found Aug 29 11:22:32 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK21d27f1cD30825F From: "Wilson" ;tag=FDFF48CE-A245F62B To: CSeq: 1 SUBSCRIBE Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:32 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:32 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:32 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:32 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bK21d27f1cD30825F From: "Wilson" ;tag=FDFF48CE-A245F62B To: ;tag=as403d5c54 Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="22786fb0" Content-Length: 0 --- Aug 29 11:22:32 VERBOSE[8578] logger.c: Scheduling destruction of call 'a99f3d82-90210b68-1d2a5c85@10.1.1.200' in 15000 ms Aug 29 11:22:32 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SUBSCRIBE sip:2000@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc986af51B61955B4 From: "Wilson" ;tag=FDFF48CE-A245F62B To: CSeq: 2 SUBSCRIBE Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="wilson-polycom", realm="asterisk", nonce="22786fb0", uri="sip:2000@10.1.1.48:5060", response="e41f0c0be4a78a26075ef6b7b10e1c96", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:32 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription a99f3d82-90210b68-1d2a5c85@10.1.1.200 Aug 29 11:22:32 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:32 VERBOSE[8578] logger.c: Sending to 10.1.1.200 : 5060 (non-NAT) Aug 29 11:22:32 VERBOSE[8578] logger.c: Found peer 'wilson-polycom' Aug 29 11:22:32 VERBOSE[8578] logger.c: Looking for 2000 in from-sip Aug 29 11:22:32 DEBUG[8578] chan_sip.c: Adding subscription for extension 2000 context from-sip for peer wilson-polycom Aug 29 11:22:32 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.200;branch=z9hG4bKc986af51B61955B4 From: "Wilson" ;tag=FDFF48CE-A245F62B To: ;tag=as0478689c Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:32 VERBOSE[8578] logger.c: Scheduling destruction of call 'a99f3d82-90210b68-1d2a5c85@10.1.1.200' in 3610000 ms Aug 29 11:22:32 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.200:5060: NOTIFY sip:wilson-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK4da5bd81 From: ;tag=as0478689c To: "Wilson" ;tag=FDFF48CE-A245F62B Contact: Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 348
--- Aug 29 11:22:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.200:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK4da5bd81 From: ;tag=as0478689c To: "Wilson" ;tag=FDFF48CE-A245F62B CSeq: 102 NOTIFY Call-ID: a99f3d82-90210b68-1d2a5c85@10.1.1.200 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:33 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a99f3d82-90210b68-1d2a5c85@10.1.1.200' of Request 102: Match Found Aug 29 11:22:33 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKad653b8fD9E19142 From: "Scott" ;tag=848AF405-84E4BB86 To: CSeq: 1 SUBSCRIBE Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (13 headers 0 lines)Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (13 headers 0 lines)--- Aug 29 11:22:33 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:33 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:33 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKad653b8fD9E19142 From: "Scott" ;tag=848AF405-84E4BB86 To: ;tag=as1e891b11 Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 CSeq: 1 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="36a8096d" Content-Length: 0 --- Aug 29 11:22:33 VERBOSE[8578] logger.c: Scheduling destruction of call '10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201' in 15000 ms Aug 29 11:22:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SUBSCRIBE sip:1002@10.1.1.48:5060 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKe9b47df067B58BB7 From: "Scott" ;tag=848AF405-84E4BB86 To: CSeq: 2 SUBSCRIBE Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 Contact: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Authorization: Digest username="scott-polycom", realm="asterisk", nonce="36a8096d", uri="sip:1002@10.1.1.48:5060", response="657cff0cfefaf64be0f601ddae3392ea", algorithm=MD5 Max-Forwards: 70 Expires: 3600 Content-Length: 0 Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (14 headers 0 lines)Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (14 headers 0 lines)--- Aug 29 11:22:33 DEBUG[8578] chan_sip.c: Got a re-subscribe on existing subscription 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 Aug 29 11:22:33 VERBOSE[8578] logger.c: Using latest SUBSCRIBE request as basis request Aug 29 11:22:33 VERBOSE[8578] logger.c: Sending to 10.1.1.201 : 5060 (non-NAT) Aug 29 11:22:33 VERBOSE[8578] logger.c: Found peer 'scott-polycom' Aug 29 11:22:33 VERBOSE[8578] logger.c: Looking for 1002 in from-sip Aug 29 11:22:33 DEBUG[8578] chan_sip.c: Adding subscription for extension 1002 context from-sip for peer scott-polycom Aug 29 11:22:33 VERBOSE[8578] logger.c: Transmitting (no NAT) to 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.201;branch=z9hG4bKe9b47df067B58BB7 From: "Scott" ;tag=848AF405-84E4BB86 To: ;tag=as69fc81fe Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 CSeq: 2 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Expires: 3600 Contact: ;expires=3600 Content-Length: 0 --- Aug 29 11:22:33 VERBOSE[8578] logger.c: Scheduling destruction of call '10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201' in 3610000 ms Aug 29 11:22:33 VERBOSE[8578] logger.c: Reliably Transmitting (no NAT) to 10.1.1.201:5060: NOTIFY sip:scott-polycom@10.1.1.48 SIP/2.0 Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK4754f47d From: ;tag=as69fc81fe To: "Scott" ;tag=848AF405-84E4BB86 Contact: Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 CSeq: 102 NOTIFY User-Agent: Asterisk PBX Event: presence Content-Type: application/xpidf+xml Subscription-State: terminated;reason=probation Retry-After: 60 Content-Length: 347
--- Aug 29 11:22:33 VERBOSE[8578] logger.c: <-- SIP read from 10.1.1.201:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.1.1.48:5060;branch=z9hG4bK4754f47d From: ;tag=as69fc81fe To: "Scott" ;tag=848AF405-84E4BB86 CSeq: 102 NOTIFY Call-ID: 10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201 Contact: Event: presence User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.5.2.0054 Content-Length: 0 Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (10 headers 0 lines)Aug 29 11:22:33 VERBOSE[8578] logger.c: --- (10 headers 0 lines)--- Aug 29 11:22:33 DEBUG[8578] chan_sip.c: Stopping retransmission on '10e7fa71-a1a6b7c3-aa7a5acc@10.1.1.201' of Request 102: Match Found Aug 29 11:22:33 VERBOSE[8578] logger.c: Response message NOTIFY arrived Aug 29 11:22:34 DEBUG[8578] chan_sip.c: Stopping retransmission on 'da9d001d-189157c3-b7965e00@10.1.1.200' of Request 102: Match Found Aug 29 11:22:34 DEBUG[8578] chan_sip.c: Stopping retransmission on '70faadd4-6e58ec4e-2de9cb6b@10.1.1.201' of Request 102: Match Found Aug 29 11:22:35 DEBUG[8578] chan_sip.c: Stopping retransmission on '8e0aa898-2495e1fe-5d66b15b@10.1.1.200' of Request 102: Match Found Aug 29 11:22:35 DEBUG[8578] chan_sip.c: Stopping retransmission on 'c0ff9e13-8eeb43d5-11e4816@10.1.1.201' of Request 102: Match Found Aug 29 11:22:36 DEBUG[8578] chan_sip.c: Stopping retransmission on 'cc9e02f3-c6437619-5f28a296@10.1.1.200' of Request 102: Match Found Aug 29 11:22:36 DEBUG[8578] chan_sip.c: Stopping retransmission on '5fb8eede-2443a888-630b163d@10.1.1.201' of Request 102: Match Found Aug 29 11:22:37 DEBUG[8578] chan_sip.c: Stopping retransmission on 'da605b2e-27626014-7ecfdb1@10.1.1.200' of Request 102: Match Found Aug 29 11:22:37 DEBUG[8578] chan_sip.c: Stopping retransmission on '9cfa2fa5-8a356257-aa913210@10.1.1.201' of Request 102: Match Found Aug 29 11:22:38 DEBUG[8578] chan_sip.c: Stopping retransmission on '275e7d49-d61e6bef-dbf80eac@10.1.1.200' of Request 102: Match Found Aug 29 11:22:38 DEBUG[8578] chan_sip.c: Stopping retransmission on '6ffe2e98-ecb891f2-39fb1d7f@10.1.1.201' of Request 102: Match Found Aug 29 11:22:39 DEBUG[8578] chan_sip.c: Stopping retransmission on 'fe58b544-4fb6e5aa-5571a187@10.1.1.200' of Request 102: Match Found Aug 29 11:22:39 DEBUG[8578] chan_sip.c: Auto destroying call '4ee64e18-22d45572-a16972ff@10.1.1.201' Aug 29 11:22:39 DEBUG[8578] chan_sip.c: Stopping retransmission on '3d467a7-96d967c9-c7d67b3a@10.1.1.201' of Request 102: Match Found Aug 29 11:22:40 DEBUG[8578] chan_sip.c: Stopping retransmission on 'b172cf1f-892e9945-df150242@10.1.1.200' of Request 102: Match Found Aug 29 11:22:40 DEBUG[8578] chan_sip.c: Stopping retransmission on '5028bf82-c5b0470c-2e7be5b1@10.1.1.201' of Request 102: Match Found Aug 29 11:22:41 DEBUG[8578] chan_sip.c: Stopping retransmission on '4e416da-35fbd2c0-cce0fcdd@10.1.1.200' of Request 102: Match Found Aug 29 11:22:41 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a81ffa99-19bdc4ab-52483214@10.1.1.201' of Request 102: Match Found Aug 29 11:22:42 DEBUG[8578] chan_sip.c: Stopping retransmission on '97a75875-8cb85e1b-12c7dd58@10.1.1.200' of Request 102: Match Found Aug 29 11:22:42 DEBUG[8578] chan_sip.c: Stopping retransmission on '6fbe201c-4e7a3256-cb3c0f53@10.1.1.201' of Request 102: Match Found Aug 29 11:22:43 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a2adff0-49d18756-795f6fb3@10.1.1.200' of Request 102: Match Found Aug 29 11:22:43 DEBUG[8578] chan_sip.c: Stopping retransmission on '30a5b8fb-5344257d-74f3b11e@10.1.1.201' of Request 102: Match Found Aug 29 11:22:44 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a300794b-b0381a71-1090ffee@10.1.1.200' of Request 102: Match Found Aug 29 11:22:44 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd1039ae6-4ac82a50-beabf6e5@10.1.1.201' of Request 102: Match Found Aug 29 11:22:45 DEBUG[8578] chan_sip.c: Stopping retransmission on '318d7086-4810636c-a0495a09@10.1.1.200' of Request 102: Match Found Aug 29 11:22:45 DEBUG[8578] chan_sip.c: Stopping retransmission on '50a6af4d-451992bf-2d813ed8@10.1.1.201' of Request 102: Match Found Aug 29 11:22:46 DEBUG[8578] chan_sip.c: Stopping retransmission on 'eeba91a1-1b622e47-d728ca04@10.1.1.200' of Request 102: Match Found Aug 29 11:22:46 DEBUG[8578] chan_sip.c: Stopping retransmission on '8a41e660-5a4d117a-f659d4e7@10.1.1.201' of Request 102: Match Found Aug 29 11:22:47 DEBUG[8578] chan_sip.c: Stopping retransmission on '1ba4289c-30c8c702-f7331bdf@10.1.1.200' of Request 102: Match Found Aug 29 11:22:47 DEBUG[8578] chan_sip.c: Stopping retransmission on 'fd44460f-d33590f1-4cceadc2@10.1.1.201' of Request 102: Match Found Aug 29 11:22:48 DEBUG[8578] chan_sip.c: Stopping retransmission on '1e4a0177-422f99d-c07f9b9a@10.1.1.200' of Request 102: Match Found Aug 29 11:22:48 DEBUG[8578] chan_sip.c: Stopping retransmission on '7ddbc50a-80d67654-2b1cddd9@10.1.1.201' of Request 102: Match Found Aug 29 11:22:49 DEBUG[8578] chan_sip.c: Stopping retransmission on 'dc3f6832-bd431218-59e91535@10.1.1.200' of Request 102: Match Found Aug 29 11:22:49 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e55761c1-c1104093-4a24fc5c@10.1.1.201' of Request 102: Match Found Aug 29 11:22:50 DEBUG[8578] chan_sip.c: Stopping retransmission on '135b28cd-e49edc73-f7bdd4b0@10.1.1.200' of Request 102: Match Found Aug 29 11:22:50 DEBUG[8578] chan_sip.c: Stopping retransmission on '331fa564-f789335e-c217623b@10.1.1.201' of Request 102: Match Found Aug 29 11:22:51 DEBUG[8578] chan_sip.c: Stopping retransmission on '70678f48-55ffa4ae-6fa60b@10.1.1.200' of Request 102: Match Found Aug 29 11:22:51 DEBUG[8578] chan_sip.c: Stopping retransmission on '72be82e3-fd77e25-b0f526@10.1.1.201' of Request 102: Match Found Aug 29 11:22:52 DEBUG[8578] chan_sip.c: Stopping retransmission on '23d267a3-313236c9-6f43d546@10.1.1.200' of Request 102: Match Found Aug 29 11:22:52 DEBUG[8578] chan_sip.c: Stopping retransmission on '267c41ee-d6a90f18-3257ee8d@10.1.1.201' of Request 102: Match Found Aug 29 11:22:53 DEBUG[8578] chan_sip.c: Stopping retransmission on 'b45cfdde-88b6dec4-35032e61@10.1.1.200' of Request 102: Match Found Aug 29 11:22:53 DEBUG[8578] chan_sip.c: Stopping retransmission on '4feae5f5-a82b0227-da6cea0@10.1.1.201' of Request 102: Match Found Aug 29 11:22:54 DEBUG[8578] chan_sip.c: Stopping retransmission on 'cfcc1df9-8e71689f-56a9fd5c@10.1.1.200' of Request 102: Match Found Aug 29 11:22:54 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e804128-a8135c02-aca16b4f@10.1.1.201' of Request 102: Match Found Aug 29 11:22:55 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd99813f4-fe59205a-8a180e37@10.1.1.200' of Request 102: Match Found Aug 29 11:22:55 DEBUG[8578] chan_sip.c: Stopping retransmission on '2234a377-11a78119-4e38cb4a@10.1.1.201' of Request 102: Match Found Aug 29 11:22:56 DEBUG[8578] chan_sip.c: Stopping retransmission on 'f79cabcf-8728d1f5-10c0acf2@10.1.1.200' of Request 102: Match Found Aug 29 11:22:56 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a3ccd592-8d54989c-82a23d01@10.1.1.201' of Request 102: Match Found Aug 29 11:22:57 DEBUG[8578] chan_sip.c: Stopping retransmission on '5cc9318a-f10ec970-905aa58d@10.1.1.200' of Request 102: Match Found Aug 29 11:22:57 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd13dcfe9-b448cb7b-9f48d9a4@10.1.1.201' of Request 102: Match Found Aug 29 11:22:58 DEBUG[8578] chan_sip.c: Stopping retransmission on '91d07125-c25cd2cb-a9904408@10.1.1.200' of Request 102: Match Found Aug 29 11:22:58 DEBUG[8578] chan_sip.c: Stopping retransmission on '24e35dac-89010f66-2ca26423@10.1.1.201' of Request 102: Match Found Aug 29 11:22:59 DEBUG[8578] chan_sip.c: Stopping retransmission on '7bd8b6a0-22383a06-caf5463@10.1.1.200' of Request 102: Match Found Aug 29 11:22:59 DEBUG[8578] chan_sip.c: Stopping retransmission on 'bd6c9bcb-ab6aedcd-ad7d342e@10.1.1.201' of Request 102: Match Found Aug 29 11:23:00 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e12bcdfb-b949cb21-cc59229e@10.1.1.200' of Request 102: Match Found Aug 29 11:23:00 DEBUG[8578] chan_sip.c: Stopping retransmission on '437603f6-59b876e0-c0709d35@10.1.1.201' of Request 102: Match Found Aug 29 11:23:01 DEBUG[8578] chan_sip.c: Stopping retransmission on '2be70336-506dd21c-ae327ab9@10.1.1.200' of Request 102: Match Found Aug 29 11:23:01 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a344739d-fff2508f-b200168@10.1.1.201' of Request 102: Match Found Aug 29 11:23:02 DEBUG[8578] chan_sip.c: Stopping retransmission on '2aab2251-ed641af7-3993a8b4@10.1.1.200' of Request 102: Match Found Aug 29 11:23:02 DEBUG[8578] chan_sip.c: Stopping retransmission on '17a35ef0-5dfc918a-a21680b7@10.1.1.201' of Request 102: Match Found Aug 29 11:23:03 DEBUG[8578] chan_sip.c: Stopping retransmission on '8f4c774c-2d7ff1b2-4438788f@10.1.1.200' of Request 102: Match Found Aug 29 11:23:03 DEBUG[8578] chan_sip.c: Stopping retransmission on '7261fdf-1ee2d841-11f1f3d2@10.1.1.201' of Request 102: Match Found Aug 29 11:23:04 DEBUG[8578] chan_sip.c: Stopping retransmission on 'eb82ce27-9e58224d-bcf0364a@10.1.1.200' of Request 102: Match Found Aug 29 11:23:04 DEBUG[8578] chan_sip.c: Stopping retransmission on '4e45111a-dac2cde4-1e9ba329@10.1.1.201' of Request 102: Match Found Aug 29 11:23:05 DEBUG[8578] chan_sip.c: Stopping retransmission on 'eb9972e2-d476f8c8-744dade5@10.1.1.200' of Request 102: Match Found Aug 29 11:23:05 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd4bee511-36e0563-1d7e9ec@10.1.1.201' of Request 102: Match Found Aug 29 11:23:06 DEBUG[8578] chan_sip.c: Stopping retransmission on '8f1f317d-a4123-a3572b60@10.1.1.200' of Request 102: Match Found Aug 29 11:23:06 DEBUG[8578] chan_sip.c: Stopping retransmission on 'ba3968f4-eb68e66e-eadfb50b@10.1.1.201' of Request 102: Match Found Aug 29 11:23:07 DEBUG[8578] chan_sip.c: Stopping retransmission on '1f9655f8-bf93475e-f0367abb@10.1.1.200' of Request 102: Match Found Aug 29 11:23:07 DEBUG[8578] chan_sip.c: Stopping retransmission on 'cf2ea3b3-bf401475-820b8e36@10.1.1.201' of Request 102: Match Found Aug 29 11:23:08 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a524ac53-f096d779-b0e8e7f6@10.1.1.200' of Request 102: Match Found Aug 29 11:23:08 DEBUG[8578] chan_sip.c: Stopping retransmission on 'ed5000fe-87481a8-1c53a2dd@10.1.1.201' of Request 102: Match Found Aug 29 11:23:09 DEBUG[8578] chan_sip.c: Stopping retransmission on '9943808e-3e4d3d74-2bef3f11@10.1.1.200' of Request 102: Match Found Aug 29 11:23:09 DEBUG[8578] chan_sip.c: Stopping retransmission on '72acf845-41941df7-d936f730@10.1.1.201' of Request 102: Match Found Aug 29 11:23:10 DEBUG[8578] chan_sip.c: Stopping retransmission on '976f9ea9-2e52454f-96fdcc0c@10.1.1.200' of Request 102: Match Found Aug 29 11:23:10 DEBUG[8578] chan_sip.c: Stopping retransmission on '34415fb8-a345d212-8f19b51f@10.1.1.201' of Request 102: Match Found Aug 29 11:23:11 DEBUG[8578] chan_sip.c: Stopping retransmission on 'cbd952a4-6b553b0a-93ac5ae7@10.1.1.200' of Request 102: Match Found Aug 29 11:23:11 DEBUG[8578] chan_sip.c: Stopping retransmission on '6e355b47-65573669-9a3475a@10.1.1.201' of Request 102: Match Found Aug 29 11:23:12 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e014687f-dc8eaa5-ea2637a2@10.1.1.200' of Request 102: Match Found Aug 29 11:23:12 DEBUG[8578] chan_sip.c: Stopping retransmission on '71d997a2-7fa5362c-bcd4b051@10.1.1.201' of Request 102: Match Found Aug 29 11:23:13 DEBUG[8578] chan_sip.c: Stopping retransmission on '25c82c3a-a293a020-41da2e3d@10.1.1.200' of Request 102: Match Found Aug 29 11:23:13 DEBUG[8578] chan_sip.c: Stopping retransmission on 'd3824139-d8628e4b-31624d34@10.1.1.201' of Request 102: Match Found Aug 29 11:23:14 DEBUG[8578] chan_sip.c: Stopping retransmission on 'bf5f69d5-afbf277b-982a8ab8@10.1.1.200' of Request 102: Match Found Aug 29 11:23:14 DEBUG[8578] chan_sip.c: Stopping retransmission on '903de73c-68d3d876-392df4f3@10.1.1.201' of Request 102: Match Found Aug 29 11:23:15 DEBUG[8578] chan_sip.c: Stopping retransmission on '86b86d50-7728ccb6-351d1913@10.1.1.200' of Request 102: Match Found Aug 29 11:23:15 DEBUG[8578] chan_sip.c: Stopping retransmission on 'f55f3a9b-4994921d-4b1b233e@10.1.1.201' of Request 102: Match Found Aug 29 11:23:16 DEBUG[8578] chan_sip.c: Stopping retransmission on '71d502ab-b7315bd1-de0b254e@10.1.1.200' of Request 102: Match Found Aug 29 11:23:16 DEBUG[8578] chan_sip.c: Stopping retransmission on 'c3f55906-4e874f70-4cda9f85@10.1.1.201' of Request 102: Match Found Aug 29 11:23:17 DEBUG[8578] chan_sip.c: Stopping retransmission on '358a75e6-296d20cc-6517b69@10.1.1.200' of Request 102: Match Found Aug 29 11:23:17 DEBUG[8578] chan_sip.c: Stopping retransmission on '981a13ed-e9510a5f-62e1cff8@10.1.1.201' of Request 102: Match Found Aug 29 11:23:18 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e6319301-7f53e7a7-be006764@10.1.1.200' of Request 102: Match Found Aug 29 11:23:18 DEBUG[8578] chan_sip.c: Stopping retransmission on '5b1c6380-eef83d9a-eda7a887@10.1.1.201' of Request 102: Match Found Aug 29 11:23:19 DEBUG[8578] chan_sip.c: Stopping retransmission on '5656a5fc-9cf0fc62-1e8bb53f@10.1.1.200' of Request 102: Match Found Aug 29 11:23:19 DEBUG[8578] chan_sip.c: Stopping retransmission on '59af5af-97b03b91-b341e5e2@10.1.1.201' of Request 102: Match Found Aug 29 11:23:20 DEBUG[8578] chan_sip.c: Stopping retransmission on 'f3697ad7-d1932afd-f57ab0fa@10.1.1.200' of Request 102: Match Found Aug 29 11:23:20 DEBUG[8578] chan_sip.c: Stopping retransmission on '7beb892a-a5ebf174-89d50479@10.1.1.201' of Request 102: Match Found Aug 29 11:23:21 DEBUG[8578] chan_sip.c: Stopping retransmission on 'e06d5d92-ce7cbf78-6d182695@10.1.1.200' of Request 102: Match Found Aug 29 11:23:21 DEBUG[8578] chan_sip.c: Stopping retransmission on 'b66b8461-8d650633-9964237c@10.1.1.201' of Request 102: Match Found Aug 29 11:23:22 DEBUG[8578] chan_sip.c: Stopping retransmission on 'ea91a2d-1b9385d3-73226210@10.1.1.200' of Request 102: Match Found Aug 29 11:23:22 DEBUG[8578] chan_sip.c: Stopping retransmission on 'b878f884-f561057e-36c7c3db@10.1.1.201' of Request 102: Match Found Aug 29 11:23:23 DEBUG[8578] chan_sip.c: Stopping retransmission on '1456fca8-ca10ca0e-9d7b2f6b@10.1.1.200' of Request 102: Match Found Aug 29 11:23:23 DEBUG[8578] chan_sip.c: Stopping retransmission on '2b50083-d02206c5-13f71346@10.1.1.201' of Request 102: Match Found Aug 29 11:23:24 DEBUG[8578] chan_sip.c: Stopping retransmission on '8154d103-25315829-4cd7daa6@10.1.1.200' of Request 102: Match Found Aug 29 11:23:24 DEBUG[8578] chan_sip.c: Stopping retransmission on 'ea5d2c0e-93470038-bedb332d@10.1.1.201' of Request 102: Match Found Aug 29 11:23:25 DEBUG[8578] chan_sip.c: Stopping retransmission on '71d3e33e-20e57c24-cd712fc1@10.1.1.200' of Request 102: Match Found Aug 29 11:23:25 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a1fd6695-c905b5c7-3f42abc0@10.1.1.201' of Request 102: Match Found Aug 29 11:23:26 DEBUG[8578] chan_sip.c: Stopping retransmission on '1f08ff59-468101ff-35b37abc@10.1.1.200' of Request 102: Match Found Aug 29 11:23:26 DEBUG[8578] chan_sip.c: Stopping retransmission on 'fa28a48-6868f422-37d8faef@10.1.1.201' of Request 102: Match Found Aug 29 11:23:27 DEBUG[8578] chan_sip.c: Stopping retransmission on '2ddc7154-df6b35ba-c2ee8797@10.1.1.200' of Request 102: Match Found Aug 29 11:23:27 DEBUG[8578] chan_sip.c: Stopping retransmission on '162b8f17-cb5587b9-298eef6a@10.1.1.201' of Request 102: Match Found Aug 29 11:23:28 DEBUG[8578] chan_sip.c: Stopping retransmission on '7b9a052f-1dcee355-7405a252@10.1.1.200' of Request 102: Match Found Aug 29 11:23:28 DEBUG[8578] chan_sip.c: Stopping retransmission on '132805b2-a7731fbc-2b603fa1@10.1.1.201' of Request 102: Match Found Aug 29 11:23:29 DEBUG[8578] chan_sip.c: Stopping retransmission on '28a106ea-34a56d0-a21f96ed@10.1.1.200' of Request 102: Match Found Aug 29 11:23:29 DEBUG[8578] chan_sip.c: Stopping retransmission on '661a4e89-b3900d1b-1dc58cc4@10.1.1.201' of Request 102: Match Found Aug 29 11:23:30 DEBUG[8578] chan_sip.c: Stopping retransmission on 'a1144285-c59f5c2b-5756b168@10.1.1.200' of Request 102: Match Found Aug 29 11:23:30 DEBUG[8578] chan_sip.c: Stopping retransmission on '355ebccc-27bb8d86-5c43c1c3@10.1.1.201' of Request 102: Match Found Aug 29 11:23:31 DEBUG[8578] chan_sip.c: Stopping retransmission on '638a0400-71633f66-2368bdc3@10.1.1.200' of Request 102: Match Found Aug 29 11:23:31 DEBUG[8578] chan_sip.c: Stopping retransmission on '35c2956b-f29e126d-4ef67e4e@10.1.1.201' of Request 102: Match Found Aug 29 11:23:32 DEBUG[8578] chan_sip.c: Stopping retransmission on '45bc175b-8aaecc81-2e6707fe@10.1.1.200' of Request 102: Match Found Aug 29 11:23:32 DEBUG[8578] chan_sip.c: Stopping retransmission on '5f0a9a16-2e35b400-c7a6fdd5@10.1.1.201' of Request 102: Match Found Aug 29 11:23:33 DEBUG[8578] chan_sip.c: Stopping retransmission on 'f737c896-6bce4f7c-49665c19@10.1.1.200' of Request 102: Match Found Aug 29 11:23:33 DEBUG[8578] chan_sip.c: Stopping retransmission on '45c4903d-c6aac02f-5627aa88@10.1.1.201' of Request 102: Match Found Aug 29 11:23:34 DEBUG[8578] chan_sip.c: Stopping retransmission on '820de3b1-21f19457-bd2f0614@10.1.1.200' of Request 102: Match Found Aug 29 11:23:34 DEBUG[8578] chan_sip.c: Stopping retransmission on 'b66df410-f7b915aa-16624c57@10.1.1.201' of Request 102: Match Found Aug 29 11:23:35 DEBUG[8578] chan_sip.c: Stopping retransmission on '8982b4ac-87dbe712-96ecd1ef@10.1.1.200' of Request 102: Match Found Aug 29 11:23:35 DEBUG[8578] chan_sip.c: Stopping retransmission on '21d7c77f-2eabae1-649783f2@10.1.1.201' of Request 102: Match Found Aug 29 11:23:36 DEBUG[8578] chan_sip.c: Stopping retransmission on '6be0787-5e9413ad-32df0baa@10.1.1.200' of Request 102: Match Found Aug 29 11:23:36 DEBUG[8578] chan_sip.c: Stopping retransmission on '88082d3a-5a82e104-3af601c9@10.1.1.201' of Request 102: Match Found