cvbabu Posted December 26, 2011 Report Posted December 26, 2011 snom m9 not registering with sip account. 408 request time out Quote
cvbabu Posted December 26, 2011 Author Report Posted December 26, 2011 snom m9 not registering. log 2000/01/01 00:01:39 [HTTP:5]: Web interface login 2000/01/01 00:00:53 [sIP-Reg:5]: Registration on identity 1 failed. Retry in 60 seconds 2000/01/01 00:00:50 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:46 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:42 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:38 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:34 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:30 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:26 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:24 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:23 [DECT:5]: Registration open 2000/01/01 00:00:23 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:22 [HTTP:5]: Webclient request via http(s), host: provisioning.snom.com 2000/01/01 00:00:22 [sIP-Reg:5]: SIP Tx udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.137.71:3263;branch=z9hG4bK-2swz2s;rport From: "extension 31" <sip:1055354@node5.ipaustria.at>;tag=xxu0pj To: "extension 31" <sip:1055354@node5.ipaustria.at> Call-ID: mtljutga@snom CSeq: 32360 REGISTER Max-Forwards: 70 Contact: <sip:1055354@192.168.137.71:3263;transport=udp;line=de1guz>;reg-id=1;+sip.instance="<urn:uuid:fda38244-51b4-4bb0-9e7b-add95f43e860>" Supported: path, outbound, gruu User-Agent: snom-m9/9.4.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:00:22 [General:4]: Bind SIP to port port 3263 2000/01/01 00:00:21 [General:5]: Start 2000/01/01 00:00:21 [General:2]: Downloading http://m9.snom.provisioning.local/configuration.xml failed with code 404 2000/01/01 00:00:21 [HTTP:1]: Webclient: DNS resolution for m9.snom.provisioning.local failed 2000/01/01 00:00:21 [HTTP:5]: Webclient request via http(s), host: provisioning.snom.com 2000/01/01 00:00:21 [General:2]: Downloading http://m9.snom.provisioning.local/configuration.xml failed with code 404 2000/01/01 00:00:21 [HTTP:1]: Webclient: DNS resolution for m9.snom.provisioning.local failed 2000/01/01 00:00:19 [Network:5]: DHCPv4: Use IP address 192.168.137.71 2000/01/01 00:00:19 [HTTP:5]: Webclient request via http(s), host: m9.snom.provisioning.local 2000/01/01 00:00:18 [General:5]: No need to upgrade GLOBALNETFTCL14N20110719,JUL 01 2009, State:2 2000/01/01 00:00:17 [DECT:5]: Initiating DCM Restart, State:1 2000/01/01 00:00:15 [HTTP:5]: Webclient request via http(s), host: m9.snom.provisioning.local 2000/01/01 00:00:15 [General:4]: Media session established 2000/01/01 00:00:15 [General:5]: Media process on 127.0.0.1:2050 2000/01/01 00:00:04 [Network:5]: Read MAC address 00041330282B 2000/01/01 00:00:04 [General:5]: Booting 2000/01/01 00:00:04 [General:5]: Read MAC address 00041330282B Quote
pbx support Posted December 27, 2011 Report Posted December 27, 2011 Can you double check if the m9 network can reach the PBX at 213.208.5.40 or node5.ipaustria.at? Also, please verify if the firewalls are configured to allow SIP traffic. Quote
cvbabu Posted December 27, 2011 Author Report Posted December 27, 2011 i cheaked snom m3 .its worked very well.with out any issu.so please help me. Quote
pbx support Posted December 27, 2011 Report Posted December 27, 2011 If the m3 and m9 are on the same network and if m3 can register with the same parameters, then it may not be the network issue. Can you check if PBX has blacklisted(Admin->Settings->Access) that IP address? Quote
Vodia PBX Posted December 27, 2011 Report Posted December 27, 2011 Also looking at the timestamp, looks like the m9 was not able to pull down the correct time. Are you sure the m9 goes to the public Internet? Quote
cvbabu Posted December 27, 2011 Author Report Posted December 27, 2011 yes, update with the new firmware.and connect with another internet service provider.different sip account. no changes the new logs 2000/01/01 00:43:39 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.1.64:2770;branch=z9hG4bK-pm81rs;rport From: "no22" <sip:1013449@node5.ipaustria.at>;tag=r4057s To: "no22" <sip:1013449@node5.ipaustria.at> Call-ID: yld383v3@snom CSeq: 4708 REGISTER Max-Forwards: 70 Contact: <sip:1013449@192.168.1.64:2770;transport=udp;line=xkz6w1>;reg-id=1;+sip.instance="<urn:uuid:5d2f04e5-d352-4b7a-9c81-fc650cd1aa45>" Supported: path, outbound, gruu User-Agent: snom-m9/9.5.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:43:39 [HTTP:5]: Web interface login 2000/01/01 00:43:35 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.1.64:2770;branch=z9hG4bK-pm81rs;rport From: "no22" <sip:1013449@node5.ipaustria.at>;tag=r4057s To: "no22" <sip:1013449@node5.ipaustria.at> Call-ID: yld383v3@snom CSeq: 4708 REGISTER Max-Forwards: 70 Contact: <sip:1013449@192.168.1.64:2770;transport=udp;line=xkz6w1>;reg-id=1;+sip.instance="<urn:uuid:5d2f04e5-d352-4b7a-9c81-fc650cd1aa45>" Supported: path, outbound, gruu User-Agent: snom-m9/9.5.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:43:31 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.1.64:2770;branch=z9hG4bK-pm81rs;rport From: "no22" <sip:1013449@node5.ipaustria.at>;tag=r4057s To: "no22" <sip:1013449@node5.ipaustria.at> Call-ID: yld383v3@snom CSeq: 4708 REGISTER Max-Forwards: 70 Contact: <sip:1013449@192.168.1.64:2770;transport=udp;line=xkz6w1>;reg-id=1;+sip.instance="<urn:uuid:5d2f04e5-d352-4b7a-9c81-fc650cd1aa45>" Supported: path, outbound, gruu User-Agent: snom-m9/9.5.7-a Expires: 3600 Content-Length: 0 2000/01/01 00:43:27 [sIP-Reg:5]: SIP Tr udp:213.208.5.40:5060: REGISTER sip:node5.ipaustria.at SIP/2.0 Via: SIP/2.0/UDP 192.168.1.64:2770;branch=z9hG4bK-pm81rs;rport From: "no22" <sip:1013449@node5.ipaustria.at>;tag=r4057s To: "no22" <sip:1013449@node5.ipaustria.at> Call-ID: yld383v3@snom CSeq: 4708 REGISTER Max-Forwards: 70 Contact: <sip:1013449@192.168.1.64:2770;transport=udp;line=xkz6w1>;reg-id=1;+sip.instance="<urn:uuid:5d2f04e5-d352-4b7a-9c81-fc650cd1aa45>" Supported: path, outbound, gruu User-Agent: snom-m9/9.5.7-a Expires: 3600 Quote
Vodia PBX Posted December 28, 2011 Report Posted December 28, 2011 Hmm. So the other SIP account works? Are you using UDP transport layer there as well? I am asking because your firewall might block UDP traffic. What firewall is it? Something "smart"? What confuses me is that the time is not set. What are you using as time server? Maybe we should focus on finding out why you don't get a time; this might be the solution for the SIP problems as well. The m9 has a feature that start the PCAP trace after reboot. If you turn it on, you will be able to see the NTP packets and possibly the responses. Then we might get an idea why the time is not being set. Quote
cvbabu Posted December 29, 2011 Author Report Posted December 29, 2011 i send it back to reseller.thank you Quote
cvbabu Posted December 29, 2011 Author Report Posted December 29, 2011 have a couple of Snom sets.now snom370 registered,and can recive calls from out side and internal calls.problem with cannot make any external calls.after few secound Network failure" upon the attempt to dial a number.example starting(0096.........) Quote
shopcomputer Posted December 30, 2011 Report Posted December 30, 2011 I can confirm there is some sort of bug with the m9 autoprovision, I tried a few m9's with various Snom One servers, they do not register when provisioned automatically, if I remove the tls and port 5061 from the sip registration, it registers fine, probably something to do with the certificates. Quote
Vodia PBX Posted December 30, 2011 Report Posted December 30, 2011 Hmm. In theory the idea was that snom products trust snom products (through the cerfiticate chain). Of course the minute you load a different certificate into the PBX that would not work any more. You can check if that is the problem by turning the certificate check off for the m9 (m9 web interface/security/certificate policy). But this is something we have to try out in the lab again. This should really be plug and play. Quote
cvbabu Posted December 30, 2011 Author Report Posted December 30, 2011 snom370 cannot make any external calls.after few secound Network failure" upon the attempt to dial a number.need help the logs Log Level -1 0 1 2 3 4 5 6 7 8 9 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_local = '1022911@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_local = '1022911@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_remote = '00096176184750 <sip:00096176184750@213.208.5.40>', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_remote = '072031660730 <sip:072031660730@213.208.5.40>', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_remote = '00096176184750 <sip:00096176184750@213.208.5.40>', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_remote = '072031660722 <sip:072031660722@213.208.5.40>', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_time = ' 9:21PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_time = ' 8:29PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_time = ' 7:27PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_time = ' 4:16PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_date = '12/24/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_missed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_received_local = '1022911@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_received_remote = '072031660722 <sip:072031660722@213.208.5.40>', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_received_time = ' 4:29PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_received_date = '12/24/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_received_duration = ' 8:57', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_local = '1055354@node5.ipaustria.at', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_remote = '00096899663738', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_remote = '00076043272', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_remote = '436644122172', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_remote = '00006644122172', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_remote = '006644122172', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_time = ' 9:20PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_time = ' 8:51PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_time = ' 8:27PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_time = ' 8:27PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_time = ' 8:26PM', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_date = '12/29/2011', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [7] 24/12/2001 00:00:23: settings::read_one_setting: callrecord_dialed_duration = ' 0:00', set.need_apply: 0, finished: 0, need reboot to apply: 0 [5] 24/12/2001 00:00:23: read_xml_settings: found network-settings XML header [5] 24/12/2001 00:00:23: read_xml_settings: found one byte encoding: 1 [5] 24/12/2001 00:00:23: read_xml_settings: found function-keys XML header [5] 24/12/2001 00:00:23: read_xml_settings: found one byte encoding: 0 [5] 24/12/2001 00:00:24: read_xml_settings: found firmware-settings XML header [5] 24/12/2001 00:00:24: read_xml_settings: found one byte encoding: 0 [1] 24/12/2001 00:00:24: SIP: opened udp port 1024 [1] 24/12/2001 00:00:24: Display disabled state: [off] [5] 24/12/2001 00:00:28: Using gui lang English at index:2 from: /mnt/snomlang/gui_lang_EN.xml [5] 24/12/2001 00:00:33: Using web lang English at index:2 from: /mnt/snomlang/web_lang_EN.xml [5] 24/12/2001 00:00:33: read_xml_settings: found dial-plan XML header [5] 24/12/2001 00:00:33: read_xml_settings: found one byte encoding: 0 [5] 24/12/2001 00:00:41: Setting up port for TR-69 [5] 24/12/2001 00:00:42: Opening TCP socket on port 7547 [0] 24/12/2001 00:00:42: Phone::uboot_version:1.1.3-u [5] 24/12/2001 00:00:42: Opening TCP socket on port 843 [5] 24/12/2001 00:00:47: Setting server was already set: http://provisioning.snom.com/snom370/snom370.php?mac={mac} [5] 24/12/2001 00:00:47: Fetching URL: http://provisioning.snom.com/snom370/snom370.php?mac=0004133A3EBB [5] 24/12/2001 00:00:49: read_xml_settings: found setting-files XML header [5] 24/12/2001 00:00:49: read_xml_settings: found one byte encoding: 1 [5] 24/12/2001 00:00:49: read_setting_file_list: added URL: http://provisioning.snom.com/config/settings_370_8_4.xml [5] 24/12/2001 00:00:49: Conf setup: found xml style settings [5] 24/12/2001 00:00:49: Fetching URL: http://provisioning.snom.com/config/settings_370_8_4.xml [5] 24/12/2001 00:00:49: read_xml_settings: found setting-files XML header [5] 24/12/2001 00:00:49: read_xml_settings: found one byte encoding: 1 [5] 24/12/2001 00:00:49: read_setting_file_list: added URL: http://provisioning.snom.com/config/web_lang_370_8_4.xml [5] 24/12/2001 00:00:49: read_setting_file_list: added URL: http://provisioning.snom.com/config/gui_lang_370_8_4.xml [5] 24/12/2001 00:00:49: Conf setup: found xml style settings [5] 24/12/2001 00:00:49: Fetching URL: http://provisioning.snom.com/config/web_lang_370_8_4.xml [5] 24/12/2001 00:00:50: read_xml_settings: found web-languages XML header [5] 24/12/2001 00:00:50: read_xml_settings: found one byte encoding: 1 [5] 24/12/2001 00:00:50: Conf setup: found xml style settings [5] 24/12/2001 00:00:50: Fetching URL: http://provisioning.snom.com/config/gui_lang_370_8_4.xml [5] 24/12/2001 00:00:50: read_xml_settings: found gui-languages XML header [5] 24/12/2001 00:00:50: read_xml_settings: found one byte encoding: 1 [5] 24/12/2001 00:00:50: Conf setup: found xml style settings [5] 24/12/2001 00:00:50: Fetching URL: http://127.0.0.1/dummy.htm [1] 24/12/2001 00:00:50: Conf setup: code: 500, host: 127.0.0.1:80, file: /dummy.htm [5] 24/12/2001 00:00:50: Fetching FW URL: http://provisioning.snom.com/snom370/snom370-firmware.htm [5] 24/12/2001 00:00:50: Fetching URL: http://provisioning.snom.com/snom370/snom370-firmware.htm [2] 24/12/2001 01:00:50: start_dst(985485600) end_dst(1004238000) offset_dst(3600) offset_utc(3600) [2] 24/12/2001 01:00:50: start DST: 03/25/2001 02:00:00 (985485600) [2] 24/12/2001 01:00:50: end DST: 10/28/2001 03:00:00 (1004238000) [5] 24/12/2001 01:00:50: read_xml_settings: found phone-book XML header [5] 24/12/2001 01:00:50: read_xml_settings: found one byte encoding: 0 [5] 24/12/2001 01:00:50: Starting straiten of tbook, size now is 0 [5] 24/12/2001 01:00:50: Done straiten of tbook, size now is 0 [5] 24/12/2001 01:00:50: Using gui lang English at index:2 from: /mnt/snomlang/gui_lang_EN.xml [5] 24/12/2001 01:00:50: Using web lang English at index:2 from: /mnt/snomlang/web_lang_EN.xml [5] 24/12/2001 01:00:52: Opening TCP socket on port 80 [5] 24/12/2001 01:00:52: Opening TCP socket on port 443 [5] 24/12/2001 01:00:52: Update: Fetching FW URL: provisioning.snom.com:80//snom370/snom370-firmware.htm done, result 200 [5] 24/12/2001 01:00:52: read_xml_settings: found no XML header; probably old style format [2] 30/12/2011 10:55:46: start_dst(1301191200) end_dst(1319943600) offset_dst(3600) offset_utc(3600) [2] 30/12/2011 10:55:46: start DST: 03/27/2011 02:00:00 (1301191200) [2] 30/12/2011 10:55:46: end DST: 10/30/2011 03:00:00 (1319943600) [5] 30/12/2011 10:55:47: sip::process_auth:Match challenge for user=1055354, realm=voicenode [2] 30/12/2011 10:55:47: Registered at registrar as 1055354@node5.ipaustria.at (Expires: 3600 secs) [5] 30/12/2011 10:56:02: send lldp advertisment [5] 30/12/2011 10:56:07: Settings applied! [5] 30/12/2011 10:57:02: send lldp advertisment [5] 30/12/2011 10:58:02: send lldp advertisment [5] 30/12/2011 10:59:02: send lldp advertisment [5] 30/12/2011 11:00:02: send lldp advertisment [5] 30/12/2011 11:00:20: rtp_port::set_port [5] 30/12/2011 11:00:23: set_audible: RP2 changed=1, update_req=0, adr= [5] 30/12/2011 11:00:23: Dialog 2/1 going to trying [5] 30/12/2011 11:00:24: sip::process_auth:Match challenge for user=1055354, realm=voicenode [5] 30/12/2011 11:00:24: Dialog 2/1 going to proceeding [5] 30/12/2011 11:00:24: Dialog 2/1 going to early [5] 30/12/2011 11:00:25: Resetting SRTP [5] 30/12/2011 11:00:25: rtp_port::set_destination RP2 adr=213.208.5.40:17772 [5] 30/12/2011 11:00:25: set_audible: RP2 changed=0, update_req=1, adr=213.208.5.40:17772 [5] 30/12/2011 11:00:31: set_audible: RP2 changed=1, update_req=0, adr=213.208.5.40:17772 [5] 30/12/2011 11:00:31: Dialog 2/1 going to terminated [5] 30/12/2011 11:00:54: rtp_port::set_port [5] 30/12/2011 11:00:59: set_audible: RP3 changed=1, update_req=0, adr= [5] 30/12/2011 11:00:59: Dialog 3/2 going to trying [5] 30/12/2011 11:01:00: sip::process_auth:Match challenge for user=1055354, realm=voicenode [5] 30/12/2011 11:01:02: testNetworkPolicyIsSet [5] 30/12/2011 11:01:02: send lldp advertisment [5] 30/12/2011 11:01:31: SIP: transport error: 1000017 -> udp:213.208.5.40:5060 [5] 30/12/2011 11:01:31: SIP: final transport error: 1000017 -> udp:213.208.5.40:5060 [2] 30/12/2011 11:01:31: Transport Error: Pending packet 1000017: generating fake [2] 30/12/2011 11:01:31: SIP: request destination invalid udp:213.208.5.40:5060 3c2671686da4-vt4k1t8r4gwi [5] 30/12/2011 11:01:31: SIP: final transport error: 1000018 -> udp:213.208.5.40:5060 [2] 30/12/2011 11:01:31: Transport Error: Pending packet 1000018: generating fake [5] 30/12/2011 11:01:31: Dialog 3/2 going to terminated [5] 30/12/2011 11:01:31: set_audible: RP3 changed=1, update_req=0, adr= [5] 30/12/2011 11:02:02: send lldp advertisment [5] 30/12/2011 11:02:32: set_audible: RP2 changed=0, update_req=0, adr=213.208.5.40:17772 [5] 30/12/2011 11:02:42: Resetting SRTP [5] 30/12/2011 11:02:42: rtp_port::set_destination adr=213.208.5.40:19594 [5] 30/12/2011 11:02:42: Dialog -2/3 going to early [5] 30/12/2011 11:02:42: rtp_port::set_port [5] 30/12/2011 11:02:50: Dialog -2/3 going to terminated [5] 30/12/2011 11:02:50: rtp_port::set_destination RP-2 adr= [5] 30/12/2011 11:02:51: set_audible: RP-2 changed=0, update_req=1, adr= [5] 30/12/2011 11:02:58: rtp_port::set_port [5] 30/12/2011 11:03:01: set_audible: RP4 changed=1, update_req=0, adr= [5] 30/12/2011 11:03:01: Dialog 4/4 going to trying [5] 30/12/2011 11:03:02: sip::process_auth:Match challenge for user=1055354, realm=voicenode [5] 30/12/2011 11:03:02: Dialog 4/4 going to proceeding [5] 30/12/2011 11:03:02: send lldp advertisment [5] 30/12/2011 11:03:02: Dialog 4/4 going to early [5] 30/12/2011 11:03:02: Resetting SRTP [5] 30/12/2011 11:03:02: rtp_port::set_destination RP4 adr=213.208.5.40:15460 [5] 30/12/2011 11:03:02: set_audible: RP4 changed=0, update_req=1, adr=213.208.5.40:15460 [5] 30/12/2011 11:03:07: set_audible: RP4 changed=1, update_req=0, adr=213.208.5.40:15460 [5] 30/12/2011 11:03:07: Dialog 4/4 going to terminated [5] 30/12/2011 11:04:02: send lldp advertisment [5] 30/12/2011 11:05:02: send lldp advertisment [5] 30/12/2011 11:05:07: set_audible: RP4 changed=0, update_req=0, adr=213.208.5.40:15460 [5] 30/12/2011 11:06:02: send lldp advertisment [5] 30/12/2011 11:07:02: send lldp advertisment [2] 30/12/2011 10:07:42: start_dst(1301191200) end_dst(1319943600) offset_dst(3600) offset_utc(0) [2] 30/12/2011 10:07:42: start DST: 03/27/2011 02:00:00 (1301191200) [2] 30/12/2011 10:07:42: end DST: 10/30/2011 03:00:00 (1319943600) [5] 30/12/2011 10:08:02: send lldp advertisment [5] 30/12/2011 10:09:02: send lldp advertisment [5] 30/12/2011 10:09:32: Resetting SRTP [5] 30/12/2011 10:09:32: rtp_port::set_destination adr=213.208.5.40:18364 [5] 30/12/2011 10:09:32: Dialog -4/5 going to early [5] 30/12/2011 10:09:33: rtp_port::set_port [5] 30/12/2011 10:09:39: Dialog -4/5 going to terminated [5] 30/12/2011 10:09:39: rtp_port::set_destination RP-4 adr= [5] 30/12/2011 10:09:39: set_audible: RP-4 changed=0, update_req=1, adr= [5] 30/12/2011 10:09:40: rtp_port::set_port [5] 30/12/2011 10:09:44: set_audible: RP5 changed=1, update_req=0, adr= [5] 30/12/2011 10:09:44: Dialog 5/6 going to trying [5] 30/12/2011 10:09:45: sip::process_auth:Match challenge for user=1055354, realm=voicenode [5] 30/12/2011 10:09:45: Dialog 5/6 going to proceeding [5] 30/12/2011 10:09:45: Dialog 5/6 going to early [5] 30/12/2011 10:09:46: Resetting SRTP [5] 30/12/2011 10:09:46: rtp_port::set_destination RP5 adr=213.208.5.40:14150 [5] 30/12/2011 10:09:46: set_audible: RP5 changed=0, update_req=1, adr=213.208.5.40:14150 [5] 30/12/2011 10:09:51: Dialog 5/6 going to confirmed [5] 30/12/2011 10:09:51: Resetting SRTP [5] 30/12/2011 10:09:51: rtp_port::set_destination RP5 adr=213.208.5.40:14150 [5] 30/12/2011 10:09:51: set_audible: RP5 changed=0, update_req=0, adr=213.208.5.40:14150 [5] 30/12/2011 10:10:02: send lldp advertisment [5] 30/12/2011 10:10:02: Dialog 5/6 going to terminated [5] 30/12/2011 10:10:02: set_audible: RP5 changed=1, update_req=0, adr=213.208.5.40:14150 [5] 30/12/2011 10:10:02: rtp_port::set_destination RP5 adr= [5] 30/12/2011 10:10:02: set_audible: RP5 changed=0, update_req=1, adr= [0] 30/12/2011 10:10:03: Deleting connected_call [5] 30/12/2011 10:11:02: send lldp advertisment [5] 30/12/2011 10:12:02: send lldp advertisment [5] 30/12/2011 10:13:02: send lldp advertisment Quote
Vodia PBX Posted December 30, 2011 Report Posted December 30, 2011 Hmm. This is the snom ONE forum, we dont have too much expertise about the phone. However, if you can attach the SIP trace maybe we are able to figure out what is going on. Quote
cvbabu Posted December 30, 2011 Author Report Posted December 30, 2011 thank you for replay. version8.4.32 downgrade to version7.3.30 now every thing working.outgoing and incomming calls. Quote
Vodia PBX Posted January 2, 2012 Report Posted January 2, 2012 Whow. I love to hear when problems are solved. Though 7.3.30 is pretty old; watch out for new versions; rumor has it there is a 8.4.33 on the way with lots of fixes, maybe one of them fixes your problem as well. Quote
Recommended Posts
Join the conversation
You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.