Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c5302-iie7q4silki7@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Using latest SUBSCRIBE request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-v9dr6ivqxv2v From: ;tag=u574i8tcs0 To: ;tag=as4f75045c Call-ID: 3c26700c5302-iie7q4silki7@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="764539f5" Content-Length: 0 --- Scheduling destruction of call '3c26700c5302-iie7q4silki7@snom320' in 15000 ms <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk;rport From: ;tag=4ky6nxawl9 To: Call-ID: 3c26700c5091-is098ip8qk7w@snom320 CSeq: 7 SUBSCRIBE Max-Forwards: 70 Contact: Event: dialog Accept: application/dialog-info+xml Expires: 0 Content-Length: 0 Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk;rport (67) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=4ky6nxawl9 (47) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c5091-is098ip8qk7w@snom320 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 7 SUBSCRIBE (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c5091-is098ip8qk7w@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Using latest SUBSCRIBE request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk From: ;tag=4ky6nxawl9 To: ;tag=as0f9162ff Call-ID: 3c26700c5091-is098ip8qk7w@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="68465352" Content-Length: 0 --- Scheduling destruction of call '3c26700c5091-is098ip8qk7w@snom320' in 15000 ms <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk;rport From: ;tag=fgkphqhvvu To: ;tag=as7cd60123 Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 CSeq: 4 SUBSCRIBE Max-Forwards: 70 Contact: Event: message-summary Accept: application/simple-message-summary Expires: 0 Content-Length: 0 Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk;rport (67) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=fgkphqhvvu (48) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: ;tag=as7cd60123 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 4 SUBSCRIBE (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (54) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2670099c40-j8e23jxuka7c@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Using latest SUBSCRIBE request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk From: ;tag=fgkphqhvvu To: ;tag=as7cd60123 Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 CSeq: 4 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="1b22e7cf" Content-Length: 0 --- Scheduling destruction of call '3c2670099c40-j8e23jxuka7c@snom320' in 15000 ms -- Asterisk Urgent handler -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver;rport From: ;tag=08st1o915c To: Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 CSeq: 5 SUBSCRIBE Max-Forwards: 70 Contact: Event: message-summary Accept: application/simple-message-summary Expires: 0 Content-Length: 0 Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver;rport (67) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=08st1o915c (47) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (27) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 5 SUBSCRIBE (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700999cf-5zqti9ju5b7h@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Using latest SUBSCRIBE request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver From: ;tag=08st1o915c To: ;tag=as76fe303d Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 CSeq: 5 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="3093feab" Content-Length: 0 --- Scheduling destruction of call '3c26700999cf-5zqti9ju5b7h@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: REGISTER sip:192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1;rport From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER Max-Forwards: 70 Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" User-Agent: snom320/4.1 Supported: gruu Allow-Events: dialog X-Real-IP: 192.168.4.3 WWW-Contact: WWW-Contact: Expires: 0 Content-Length: 0 Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1;rport (67) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320 pundit" ;tag=c1nu81mvjj (64) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320 pundit" (47) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 14 REGISTER (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (298) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (16 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2672183f7a-zp54s5lyemny@snom320 - REGISTER (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Using latest request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1 From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 --- Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1 From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" ;tag=as3d11e73f Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="255cf8a2" Content-Length: 0 --- Scheduling destruction of call '3c2672183f7a-zp54s5lyemny@snom320' in 15000 ms <-- SIP read from 192.168.4.3:2051: REGISTER sip:192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn;rport From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER Max-Forwards: 70 Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" User-Agent: snom320/4.1 Supported: gruu Allow-Events: dialog X-Real-IP: 192.168.4.3 WWW-Contact: WWW-Contact: Expires: 0 Content-Length: 0 Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn;rport (67) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320b pundit" ;tag=6wtngd2b4u (66) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320b pundit" (49) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 (42) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 3 REGISTER (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (299) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (16 headers 0 lines)--- Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700999cf-71ngpmgyzjr2@snom320 - REGISTER (No RTP) Oct 2 20:29:47 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Using latest request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 --- -- Asterisk Urgent handler -- Asterisk Urgent handler Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" ;tag=as4b346389 Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="162b6174" Content-Length: 0 --- Scheduling destruction of call '3c26700999cf-71ngpmgyzjr2@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:500@192.168.4.11;user=phone SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-kvzby6tydxv4;rport From: ;tag=gsr31m9trt To: Call-ID: 3c26700c57e4-09yvn7oxkd62@snom320 CSeq: 7 SUBSCRIBE Max-Forwards: 70 Contact: Event: dialog Accept: application/dialog-info+xml Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:500@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-kvzby6tydxv4;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=gsr31m9trt (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c57e4-09yvn7oxkd62@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 7 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 7, ours 7) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-kvzby6tydxv4 From: ;tag=gsr31m9trt To: ;tag=as3363f181 Call-ID: 3c26700c57e4-09yvn7oxkd62@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="5ed30998" Content-Length: 0 --- Scheduling destruction of call '3c26700c57e4-09yvn7oxkd62@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:8400@192.168.4.11;user=phone SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-bdc2yook0rwh;rport From: ;tag=dhh7t97te5 To: Call-ID: 3c26700c5573-y9daryutp9qd@snom320 CSeq: 7 SUBSCRIBE Max-Forwards: 70 Contact: Event: dialog Accept: application/dialog-info+xml Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:8400@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-bdc2yook0rwh;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=dhh7t97te5 (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c5573-y9daryutp9qd@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 7 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 7, ours 7) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-bdc2yook0rwh From: ;tag=dhh7t97te5 To: ;tag=as5ed161a1 Call-ID: 3c26700c5573-y9daryutp9qd@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="0b13d99b" Content-Length: 0 --- Scheduling destruction of call '3c26700c5573-y9daryutp9qd@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:144@192.168.4.11;user=phone SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-v9dr6ivqxv2v;rport From: ;tag=u574i8tcs0 To: Call-ID: 3c26700c5302-iie7q4silki7@snom320 CSeq: 7 SUBSCRIBE Max-Forwards: 70 Contact: Event: dialog Accept: application/dialog-info+xml Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:144@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-v9dr6ivqxv2v;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=u574i8tcs0 (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c5302-iie7q4silki7@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 7 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 7, ours 7) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-v9dr6ivqxv2v From: ;tag=u574i8tcs0 To: ;tag=as4f75045c Call-ID: 3c26700c5302-iie7q4silki7@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="764539f5" Content-Length: 0 --- Scheduling destruction of call '3c26700c5302-iie7q4silki7@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk;rport From: ;tag=4ky6nxawl9 To: Call-ID: 3c26700c5091-is098ip8qk7w@snom320 CSeq: 7 SUBSCRIBE Max-Forwards: 70 Contact: Event: dialog Accept: application/dialog-info+xml Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=4ky6nxawl9 (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c5091-is098ip8qk7w@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 7 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 7, ours 7) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-lfuzw9nrmzuk From: ;tag=4ky6nxawl9 To: ;tag=as0f9162ff Call-ID: 3c26700c5091-is098ip8qk7w@snom320 CSeq: 7 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="68465352" Content-Length: 0 --- Scheduling destruction of call '3c26700c5091-is098ip8qk7w@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk;rport From: ;tag=fgkphqhvvu To: ;tag=as7cd60123 Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 CSeq: 4 SUBSCRIBE Max-Forwards: 70 Contact: Event: message-summary Accept: application/simple-message-summary Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=fgkphqhvvu (48) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: ;tag=as7cd60123 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 4 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (54) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 4, ours 4) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-72p7tlo8emzk From: ;tag=fgkphqhvvu To: ;tag=as7cd60123 Call-ID: 3c2670099c40-j8e23jxuka7c@snom320 CSeq: 4 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="1b22e7cf" Content-Length: 0 --- Scheduling destruction of call '3c2670099c40-j8e23jxuka7c@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver;rport From: ;tag=08st1o915c To: Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 CSeq: 5 SUBSCRIBE Max-Forwards: 70 Contact: Event: message-summary Accept: application/simple-message-summary Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=08st1o915c (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (27) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 5 SUBSCRIBE (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (12 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (SUBSCRIBE Seqno 5, ours 5) Ignoring this SUBSCRIBE request Found peer 'snom320b' Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-4fa1uwhfvver From: ;tag=08st1o915c To: ;tag=as76fe303d Call-ID: 3c26700999cf-5zqti9ju5b7h@snom320 CSeq: 5 SUBSCRIBE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="3093feab" Content-Length: 0 --- Scheduling destruction of call '3c26700999cf-5zqti9ju5b7h@snom320' in 15000 ms -- Asterisk Urgent handler <-- SIP read from 192.168.4.3:2051: REGISTER sip:192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1;rport From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER Max-Forwards: 70 Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" User-Agent: snom320/4.1 Supported: gruu Allow-Events: dialog X-Real-IP: 192.168.4.3 WWW-Contact: WWW-Contact: Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320 pundit" ;tag=c1nu81mvjj (64) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320 pundit" (47) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 14 REGISTER (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (298) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (16 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (REGISTER Seqno 14, ours 14) Using latest request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1 From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 --- Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-icorkmd461j1 From: "snom320 pundit" ;tag=c1nu81mvjj To: "snom320 pundit" ;tag=as3d11e73f Call-ID: 3c2672183f7a-zp54s5lyemny@snom320 CSeq: 14 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="255cf8a2" Content-Length: 0 --- Scheduling destruction of call '3c2672183f7a-zp54s5lyemny@snom320' in 15000 ms <-- SIP read from 192.168.4.3:2051: REGISTER sip:192.168.4.11 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn;rport From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER Max-Forwards: 70 Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" User-Agent: snom320/4.1 Supported: gruu Allow-Events: dialog X-Real-IP: 192.168.4.3 WWW-Contact: WWW-Contact: Expires: 0 Content-Length: 0 Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn;rport (67) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320b pundit" ;tag=6wtngd2b4u (66) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320b pundit" (49) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 (42) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 3 REGISTER (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (299) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 0 (10) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) --- (16 headers 0 lines)--- Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Oct 2 20:29:48 DEBUG[2247]: chan_sip.c:9930 handle_request: Ignoring SIP message because of retransmit (REGISTER Seqno 3, ours 3) Using latest request as basis request Sending to 192.168.4.3 : 2051 (non-NAT) Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 --- Transmitting (no NAT) to 192.168.4.3:2051: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.4.3:2051;branch=z9hG4bK-w7g14vcnyvzn From: "snom320b pundit" ;tag=6wtngd2b4u To: "snom320b pundit" ;tag=as4b346389 Call-ID: 3c26700999cf-71ngpmgyzjr2@snom320 CSeq: 3 REGISTER User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: WWW-Authenticate: Digest realm="asterisk", nonce="162b6174" Content-Length: 0 --- Scheduling destruction of call '3c26700999cf-71ngpmgyzjr2@snom320' in 15000 ms -- Asterisk Urgent handler -- Asterisk Urgent handler Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 (58) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 (57) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as605df7ab (59) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (36) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 (54) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 OPTIONS (17) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: Asterisk PBX (24) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Date: Sun, 02 Oct 2005 18:29:50 GMT (35) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY (55) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) 11 headers, 0 lines Reliably Transmitting (no NAT) to 192.168.4.3:2051: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 From: "asterisk" ;tag=as605df7ab To: Contact: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Date: Sun, 02 Oct 2005 18:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Content-Length: 0 --- Oct 2 20:29:50 DEBUG[2247]: chan_sip.c:1179 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #36 -- Asterisk Urgent handler Oct 2 20:29:51 DEBUG[2247]: chan_sip.c:1065 retrans_pkt: SIP TIMER: Not rescheduling id #36:OPTIONS (Method 3) (No timer T1) Retransmitting #1 (no NAT) to 192.168.4.3:2051: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 From: "asterisk" ;tag=as605df7ab To: Contact: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Date: Sun, 02 Oct 2005 18:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Content-Length: 0 --- -- Asterisk Urgent handler Oct 2 20:29:52 DEBUG[2247]: chan_sip.c:1065 retrans_pkt: SIP TIMER: Not rescheduling id #36:OPTIONS (Method 3) (No timer T1) Retransmitting #2 (no NAT) to 192.168.4.3:2051: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 From: "asterisk" ;tag=as605df7ab To: Contact: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Date: Sun, 02 Oct 2005 18:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Content-Length: 0 --- -- Asterisk Urgent handler Oct 2 20:29:53 DEBUG[2247]: chan_sip.c:1065 retrans_pkt: SIP TIMER: Not rescheduling id #36:OPTIONS (Method 3) (No timer T1) Retransmitting #3 (no NAT) to 192.168.4.3:2051: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 From: "asterisk" ;tag=as605df7ab To: Contact: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Date: Sun, 02 Oct 2005 18:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Content-Length: 0 --- -- Asterisk Urgent handler Oct 2 20:29:54 DEBUG[2247]: chan_sip.c:1065 retrans_pkt: SIP TIMER: Not rescheduling id #36:OPTIONS (Method 3) (No timer T1) Retransmitting #4 (no NAT) to 192.168.4.3:2051: OPTIONS sip:snom320@192.168.4.3:2051;line=omr90s70 SIP/2.0 Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0e627922 From: "asterisk" ;tag=as605df7ab To: Contact: Call-ID: 54619d4250668ba953ceb6736c79a22e@192.168.4.11 CSeq: 102 OPTIONS User-Agent: Asterisk PBX Date: Sun, 02 Oct 2005 18:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Content-Length: 0 --- Oct 2 20:29:54 NOTICE[2247]: chan_sip.c:10311 sip_poke_noanswer: Peer 'snom320' is now UNREACHABLE! Last qualify: 75 Destroying call '54619d4250668ba953ceb6736c79a22e@192.168.4.11' -- Asterisk Urgent handler Oct 2 20:29:54 DEBUG[2247]: devicestate.c:166 do_state_change: Changing state for SIP/snom320 - state 5 (Unavailable) Oct 2 20:29:54 DEBUG[2247]: app_queue.c:429 changethread: Device 'SIP/snom320' changed to state '5' (Unavailable) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-vf3n8ozgos39;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320 pundit" ;tag=okhklnn9bp (64) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320 pundit" (47) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093827-t3k7h5vs7qpu@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 REGISTER (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (298) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2670093827-t3k7h5vs7qpu@snom320 - REGISTER (No RTP) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-swsdcx5axwc4;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320b pundit" ;tag=7htvvpcraw (66) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320b pundit" (49) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093d09-71ngpmgyzjr2@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 REGISTER (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (299) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2670093d09-71ngpmgyzjr2@snom320 - REGISTER (No RTP) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-ithxndk7epq5;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=08st1o915c (47) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (27) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093f7a-5zqti9ju5b7h@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2670093f7a-5zqti9ju5b7h@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:1234@192.168.4.11 SIP/2.0 (39) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-pa092eys31lh;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=fgkphqhvvu (48) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (27) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093f7a-j8e23jxuka7c@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (54) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/simple-message-summary (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c2670093f7a-j8e23jxuka7c@snom320 - SUBSCRIBE (No RTP) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-4cdtf52exrgn;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320 pundit" ;tag=okhklnn9bp (64) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320 pundit" (47) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093827-t3k7h5vs7qpu@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 REGISTER (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (298) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Authorization: Digest username="snom320",realm="asterisk",nonce="07d27148",uri="sip:192.168.4.11",response="6d86a1efccd536ef5890a8d604266eec",algorithm=md5 (155) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: OPTIONS sip:snom320@192.168.4.3:2054;line=omr90s70 SIP/2.0 (58) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0106a545 (57) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as0ddf2523 (59) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (36) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 66ab177f6fb6bd8a6d5b65b1734a76ba@192.168.4.11 (54) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 OPTIONS (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: Asterisk PBX (24) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Date: Sun, 02 Oct 2005 18:29:58 GMT (35) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY (55) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:1179 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #42 -- Registered SIP 'snom320' at 192.168.4.3 port 2054 expires 3600 -- Asterisk Urgent handler Oct 2 20:29:58 DEBUG[2247]: devicestate.c:166 do_state_change: Changing state for SIP/snom320 - state 5 (Unavailable) Oct 2 20:29:58 DEBUG[2247]: app_queue.c:429 changethread: Device 'SIP/snom320' changed to state '5' (Unavailable) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: REGISTER sip:192.168.4.11 SIP/2.0 (33) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-g5nj3gj4zym3;rport (67) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "snom320b pundit" ;tag=7htvvpcraw (66) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: "snom320b pundit" (49) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c2670093d09-71ngpmgyzjr2@snom320 (42) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 REGISTER (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: ;q=1.0;+sip.instance="";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO" (299) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: gruu (15) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: dialog (20) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: X-Real-IP: 192.168.4.3 (22) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (36) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: WWW-Contact: (38) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Authorization: Digest username="snom320b",realm="asterisk",nonce="345439e5",uri="sip:192.168.4.11",response="fff0278e2d84a3de5d2c7fbb8a18ed13",algorithm=md5 (156) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received REGISTER (2) - Command in SIP REGISTER -- Registered SIP 'snom320b' at 192.168.4.3 port 2054 expires 3600 -- Saved useragent "snom320/4.1" for peer snom320b -- Asterisk Urgent handler Oct 2 20:29:58 DEBUG[2247]: devicestate.c:166 do_state_change: Changing state for SIP/snom320b - state 0 (Unknown) Oct 2 20:29:58 DEBUG[2247]: app_queue.c:429 changethread: Device 'SIP/snom320b' changed to state '0' (Unknown) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SIP/2.0 200 OK (14) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK0106a545 (57) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as0ddf2523 (59) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 66ab177f6fb6bd8a6d5b65b1734a76ba@192.168.4.11 (54) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 OPTIONS (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept-Language: en (19) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/sdp (23) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO (88) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: talk, hold, refer (31) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: timer, 100rel, replaces, callerid (44) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:1263 __sip_ack: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #42 Oct 2 20:29:58 DEBUG[2247]: chan_sip.c:1274 __sip_ack: Stopping retransmission on '66ab177f6fb6bd8a6d5b65b1734a76ba@192.168.4.11' of Request 102: Match Found Oct 2 20:29:58 NOTICE[2247]: chan_sip.c:8770 handle_response_peerpoke: Peer 'snom320' is now REACHABLE! (57ms / 2000ms) Oct 2 20:29:58 DEBUG[2247]: devicestate.c:166 do_state_change: Changing state for SIP/snom320 - state 0 (Unknown) Oct 2 20:29:58 DEBUG[2247]: app_queue.c:429 changethread: Device 'SIP/snom320' changed to state '0' (Unknown) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-yxvh2f082m5q;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=li5o284qaz (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c04e2-2doa5yy1vb00@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c04e2-2doa5yy1vb00@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:144@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-m2d6uzs0poux;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=zkcjbmy5c2 (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0753-waoub35b33ak@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c0753-waoub35b33ak@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:8400@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-peqhezq9gszg;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=qruoc6qu4j (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c09c4-26081nvbrqkf@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c09c4-26081nvbrqkf@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:500@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-g7kq01iz1nzp;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=8fufpey6s1 (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0c35-k0nzweq0e4rw@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 1 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c0c35-k0nzweq0e4rw@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-vncf1g6x1dr0;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=li5o284qaz (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c04e2-2doa5yy1vb00@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="6b67d4fa",uri="sip:5678@192.168.4.11;user=phone",response="fc1d647c82a85a0483222d0a953e0aaf",algorithm=md5 (177) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 NOTICE[2247]: chan_sip.c:9737 handle_request_subscribe: Failed to authenticate user ;tag=li5o284qaz for SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:144@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-pqliblpwbpxe;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=zkcjbmy5c2 (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0753-waoub35b33ak@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="3f8d9460",uri="sip:144@192.168.4.11;user=phone",response="9afd8fa86ed669b0e9e60653d620fba5",algorithm=md5 (176) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 NOTICE[2247]: chan_sip.c:9737 handle_request_subscribe: Failed to authenticate user ;tag=zkcjbmy5c2 for SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:8400@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-y177nnvk2gkt;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=qruoc6qu4j (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c09c4-26081nvbrqkf@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="587cb048",uri="sip:8400@192.168.4.11;user=phone",response="57b196c29edeac839dd426501e55634c",algorithm=md5 (177) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 NOTICE[2247]: chan_sip.c:9737 handle_request_subscribe: Failed to authenticate user ;tag=qruoc6qu4j for SUBSCRIBE Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:500@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-lq95dzwjhr4q;rport (67) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=8fufpey6s1 (47) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0c35-k0nzweq0e4rw@snom320 (42) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="4afa3738",uri="sip:500@192.168.4.11;user=phone",response="37a5d2b2164f13556b48aa945edd772e",algorithm=md5 (176) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:00 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:00 NOTICE[2247]: chan_sip.c:9737 handle_request_subscribe: Failed to authenticate user ;tag=8fufpey6s1 for SUBSCRIBE Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:5678@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-vncf1g6x1dr0;rport (67) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=li5o284qaz (47) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c04e2-2doa5yy1vb00@snom320 (42) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="6b67d4fa",uri="sip:5678@192.168.4.11;user=phone",response="fc1d647c82a85a0483222d0a953e0aaf",algorithm=md5 (177) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c04e2-2doa5yy1vb00@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:144@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-pqliblpwbpxe;rport (67) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=zkcjbmy5c2 (47) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0753-waoub35b33ak@snom320 (42) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="3f8d9460",uri="sip:144@192.168.4.11;user=phone",response="9afd8fa86ed669b0e9e60653d620fba5",algorithm=md5 (176) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c0753-waoub35b33ak@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:8400@192.168.4.11;user=phone SIP/2.0 (50) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-y177nnvk2gkt;rport (67) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=qruoc6qu4j (47) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (38) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c09c4-26081nvbrqkf@snom320 (42) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="587cb048",uri="sip:8400@192.168.4.11;user=phone",response="57b196c29edeac839dd426501e55634c",algorithm=md5 (177) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c09c4-26081nvbrqkf@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SUBSCRIBE sip:500@192.168.4.11;user=phone SIP/2.0 (49) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.3:2054;branch=z9hG4bK-lq95dzwjhr4q;rport (67) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: ;tag=8fufpey6s1 (47) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (37) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 3c26700c0c35-k0nzweq0e4rw@snom320 (42) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 2 SUBSCRIBE (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Max-Forwards: 70 (16) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (53) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: dialog (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/dialog-info+xml (35) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Proxy-Authorization: Digest username="snom320",realm="asterisk",nonce="4afa3738",uri="sip:500@192.168.4.11;user=phone",response="37a5d2b2164f13556b48aa945edd772e",algorithm=md5 (176) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Expires: 3600 (13) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for 3c26700c0c35-k0nzweq0e4rw@snom320 - SUBSCRIBE (No RTP) Oct 2 20:30:01 DEBUG[2247]: chan_sip.c:9919 handle_request: **** Received SUBSCRIBE (10) - Command in SIP SUBSCRIBE Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c57e4-09yvn7oxkd62@snom320' Destroying call '3c26700c57e4-09yvn7oxkd62@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c5573-y9daryutp9qd@snom320' Destroying call '3c26700c5573-y9daryutp9qd@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c5302-iie7q4silki7@snom320' Destroying call '3c26700c5302-iie7q4silki7@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c5091-is098ip8qk7w@snom320' Destroying call '3c26700c5091-is098ip8qk7w@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c2670099c40-j8e23jxuka7c@snom320' Destroying call '3c2670099c40-j8e23jxuka7c@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700999cf-5zqti9ju5b7h@snom320' Destroying call '3c26700999cf-5zqti9ju5b7h@snom320' -- Asterisk Urgent handler Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c2672183f7a-zp54s5lyemny@snom320' Destroying call '3c2672183f7a-zp54s5lyemny@snom320' Oct 2 20:30:03 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700999cf-71ngpmgyzjr2@snom320' Destroying call '3c26700999cf-71ngpmgyzjr2@snom320' -- Asterisk Urgent handler Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for (No Call-ID) - NOTIFY (No RTP) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: NOTIFY sip:snom320b@192.168.4.3:2054;line=d30gksyg SIP/2.0 (58) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK6dc434c4;rport (63) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as13212d66 (59) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (49) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (36) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 485836172602566b574e97147cecf9f9@192.168.4.11 (54) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 NOTIFY (16) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: Asterisk PBX (24) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Type: application/simple-message-summary (48) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 80 (18) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Message-Account: sip:asterisk@ (30) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Messages-Waiting: no (20) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Voice-Message: 0/0 (0/0) (24) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1179 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #56 Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for (No Call-ID) - NOTIFY (No RTP) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: NOTIFY sip:snom320@192.168.4.3:2054;line=omr90s70 SIP/2.0 (57) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK68feeac5;rport (63) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as3d608807 (59) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (36) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 2feec0a93e89f92f465c6a777b31af7e@192.168.4.11 (54) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 NOTIFY (16) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: Asterisk PBX (24) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Event: message-summary (22) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Type: application/simple-message-summary (48) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 80 (18) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Message-Account: sip:asterisk@ (30) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Messages-Waiting: no (20) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3203 parse_request: Line: Voice-Message: 0/0 (0/0) (24) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1179 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #58 Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SIP/2.0 200 Ok (14) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK6dc434c4;rport=5060 (68) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as13212d66 (59) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (49) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 485836172602566b574e97147cecf9f9@192.168.4.11 (54) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 NOTIFY (16) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1263 __sip_ack: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #56 Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1274 __sip_ack: Stopping retransmission on '485836172602566b574e97147cecf9f9@192.168.4.11' of Request 102: Match Found Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SIP/2.0 200 Ok (14) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK68feeac5;rport=5060 (68) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as3d608807 (59) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 2feec0a93e89f92f465c6a777b31af7e@192.168.4.11 (54) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 NOTIFY (16) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1263 __sip_ack: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #58 Oct 2 20:30:07 DEBUG[2247]: chan_sip.c:1274 __sip_ack: Stopping retransmission on '2feec0a93e89f92f465c6a777b31af7e@192.168.4.11' of Request 102: Match Found Oct 2 20:30:13 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c2670093827-t3k7h5vs7qpu@snom320' Oct 2 20:30:13 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c2670093d09-71ngpmgyzjr2@snom320' Oct 2 20:30:16 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c04e2-2doa5yy1vb00@snom320' Oct 2 20:30:16 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c0753-waoub35b33ak@snom320' Oct 2 20:30:16 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c09c4-26081nvbrqkf@snom320' Oct 2 20:30:16 DEBUG[2247]: chan_sip.c:1197 __sip_autodestruct: Auto destroying call '3c26700c0c35-k0nzweq0e4rw@snom320' Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:2978 sip_alloc: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: OPTIONS sip:snom320@192.168.4.3:2054;line=omr90s70 SIP/2.0 (58) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK3f785407 (57) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as3d97b9c5 (59) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (36) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 48fbd02539b6196e363293434411b866@192.168.4.11 (54) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 OPTIONS (17) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: Asterisk PBX (24) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Date: Sun, 02 Oct 2005 18:30:58 GMT (35) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY (55) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:1179 __sip_reliable_xmit: *** SIP TIMER: Initalizing retransmit timer on packet: Id #60 Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: SIP/2.0 200 OK (14) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Via: SIP/2.0/UDP 192.168.4.11:5060;branch=z9hG4bK3f785407 (57) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: From: "asterisk" ;tag=as3d97b9c5 (59) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: To: (48) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Call-ID: 48fbd02539b6196e363293434411b866@192.168.4.11 (54) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: CSeq: 102 OPTIONS (17) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Contact: (54) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: User-Agent: snom320/4.1 (23) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept-Language: en (19) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Accept: application/sdp (23) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO (88) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Allow-Events: talk, hold, refer (31) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Supported: timer, 100rel, replaces, callerid (44) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: Content-Length: 0 (17) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:3174 parse_request: Header: (0) Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:1263 __sip_ack: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #60 Oct 2 20:30:58 DEBUG[2247]: chan_sip.c:1274 __sip_ack: Stopping retransmission on '48fbd02539b6196e363293434411b866@192.168.4.11' of Request 102: Match Found