hi all,
For past few days I am facing local calls dropping issue. Local calls drop sometime by picking up the phone sometime during the call channel hung up.
I have 240 IP phones network connected via a switched network.
Please need any troubleshooting guide or any idea to fix this issue.
There is absolutely no way we can help you fix this problem.
We need the minimal information to get started: software versions, examples from the logs, types of connections, basic trunk setups (no passwords!), sample extension setup, etc.
what do you mean by connections, and there is no trunk calling involve currently only local calls from the same pbx server (PBX Firmware:5.211.65-3) and its freepbx distro.
sample extension setup = xxx
what type of logs you required.
Is there anyone to help me on this issue.
I’m not sure what part of “No one can help you without more information” you don’t understand.
The log files are in /var/log/asterisk/full, or you can access them from the FreePBX GUI.
Without more information, we’d have to guess, and there are literally thousands of things that could be wrong. I’m not willing to just post question after question trying to guess at what you’ve messed up.
hi cynjut,
thanks bro I will be sending you the full.log in a moment.
hi,
please find some logs from /var/log/asterisk/fail2ban
[2017-02-07 13:32:41] WARNING[22805][C-0000256f] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:32:42] NOTICE[22805] chan_sip.c: Disconnecting call ‘SIP/1013-0000760f’ for lack of RTP activity in 31 seconds
[2017-02-07 13:32:42] NOTICE[22805] chan_sip.c: Disconnecting call ‘SIP/179-000075c8’ for lack of RTP activity in 31 seconds
[2017-02-07 13:32:42] NOTICE[22805] chan_sip.c: Disconnecting call ‘SIP/179-000075c8’ for lack of RTP activity in 31 seconds
[2017-02-07 13:32:50] NOTICE[22805] chan_sip.c: Peer ‘332’ is now UNREACHABLE! Last qualify: 92
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘1013’ is now UNREACHABLE! Last qualify: 98
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘199’ is now UNREACHABLE! Last qualify: 94
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘171’ is now UNREACHABLE! Last qualify: 102
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘179’ is now UNREACHABLE! Last qualify: 117
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘805’ is now UNREACHABLE! Last qualify: 93
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘482’ is now UNREACHABLE! Last qualify: 94
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘187’ is now UNREACHABLE! Last qualify: 93
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘185’ is now UNREACHABLE! Last qualify: 91
[2017-02-07 13:32:51] NOTICE[22805] chan_sip.c: Peer ‘914’ is now UNREACHABLE! Last qualify: 95
[2017-02-07 13:32:52] NOTICE[22805] chan_sip.c: Peer ‘180’ is now UNREACHABLE! Last qualify: 88
[2017-02-07 13:32:52] NOTICE[22805] chan_sip.c: Peer ‘493’ is now UNREACHABLE! Last qualify: 97
[2017-02-07 13:32:52] NOTICE[22805] chan_sip.c: Peer ‘1012’ is now UNREACHABLE! Last qualify: 89
[2017-02-07 13:32:52] NOTICE[22805] chan_sip.c: Peer ‘181’ is now UNREACHABLE! Last qualify: 98
[2017-02-07 13:32:52] NOTICE[22805] chan_sip.c: Peer ‘184’ is now UNREACHABLE! Last qualify: 93
[2017-02-07 13:32:53] NOTICE[22805] chan_sip.c: Peer ‘309’ is now UNREACHABLE! Last qualify: 98
[2017-02-07 13:32:54] NOTICE[22805] chan_sip.c: Peer ‘172’ is now UNREACHABLE! Last qualify: 94
[2017-02-07 13:32:55] NOTICE[22805] chan_sip.c: Peer ‘905’ is now UNREACHABLE! Last qualify: 94
[2017-02-07 13:33:03] NOTICE[22805] chan_sip.c: Peer ‘184’ is now Reachable. (220ms / 2000ms)
[2017-02-07 13:33:04] NOTICE[22805] chan_sip.c: Peer ‘309’ is now Reachable. (571ms / 2000ms)
[2017-02-07 13:33:05] NOTICE[22805] chan_sip.c: Peer ‘332’ is now Reachable. (205ms / 2000ms)
[2017-02-07 13:33:05] NOTICE[22805] chan_sip.c: Peer ‘172’ is now Reachable. (205ms / 2000ms)
[2017-02-07 13:33:05] NOTICE[22805] chan_sip.c: Peer ‘199’ is now Reachable. (204ms / 2000ms)
[2017-02-07 13:33:05] NOTICE[22805] chan_sip.c: Peer ‘1013’ is now Reachable. (219ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘171’ is now Reachable. (241ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘179’ is now Reachable. (223ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘805’ is now Reachable. (204ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘905’ is now Reachable. (217ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘482’ is now Reachable. (212ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘187’ is now Reachable. (206ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘185’ is now Reachable. (211ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘914’ is now Reachable. (213ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘180’ is now Reachable. (200ms / 2000ms)
[2017-02-07 13:33:06] NOTICE[22805] chan_sip.c: Peer ‘493’ is now Reachable. (217ms / 2000ms)
[2017-02-07 13:33:07] NOTICE[22805] chan_sip.c: Peer ‘1012’ is now Reachable. (201ms / 2000ms)
[2017-02-07 13:33:07] NOTICE[22805] chan_sip.c: Peer ‘181’ is now Reachable. (210ms / 2000ms)
[2017-02-07 13:33:11] WARNING[1807][C-00002572] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:33:11] WARNING[1807][C-00002572] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:33:13] WARNING[22805][C-00002572] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:33:17] WARNING[1800][C-00002571] mp3/interface.c: Junk at the beginning of frame 49443304
[2017-02-07 13:33:29] WARNING[1840][C-00002571] app_dial.c: Unable to create channel of type ‘SIP’ (cause 20 - Subscriber absent)
[2017-02-07 13:33:32] WARNING[22805][C-00002571] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:33:33] NOTICE[22805] chan_sip.c: Peer ‘518’ is now Lagged. (2133ms / 2000ms)
[2017-02-07 13:33:38] WARNING[1851][C-00002575] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:33:38] WARNING[1851][C-00002575] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:33:38] WARNING[1851][C-00002575] func_presencestate.c: PRESENCE_STATE unknown
[2017-02-07 13:33:39] NOTICE[22805] chan_sip.c: Peer ‘1005’ is now Lagged. (2106ms / 2000ms)
[2017-02-07 13:33:43] NOTICE[22805] chan_sip.c: Peer ‘518’ is now Reachable. (133ms / 2000ms)
[2017-02-07 13:33:45] WARNING[22805][C-00002573] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:33:49] NOTICE[22805] chan_sip.c: Peer ‘1005’ is now Reachable. (109ms / 2000ms)
[2017-02-07 13:33:56] WARNING[22805] chan_sip.c: Retransmission timeout reached on transmission [email protected] for seqno 102 (Critical Response) – See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 14272ms with no response
[2017-02-07 13:34:03] WARNING[1851][C-00002575] mp3/interface.c: Junk at the beginning of frame 49443304
[2017-02-07 13:34:06] WARNING[22805][C-00002570] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:34:13] NOTICE[22805] chan_sip.c: Peer ‘150’ is now Lagged. (2114ms / 2000ms)
[2017-02-07 13:34:23] NOTICE[22805] chan_sip.c: Peer ‘150’ is now Reachable. (111ms / 2000ms)
[2017-02-07 13:34:28] WARNING[22805][C-00002570] chan_sip.c: Ignoring video stream offer because port number is zero
[2017-02-07 13:34:30] WARNING[1943][C-00002578] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:34:30] WARNING[1943][C-00002578] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2017-02-07 13:34:32] SECURITY[22783] res_security_log.c: SecurityEvent=“SuccessfulAuth”,EventTV=“1486492355-167098”,Severity=“Informational”,Service=“SIP”,EventVersion=“1”,AccountID=“388”,SessionID=“0x7f01f4e02768”,LocalAddress=“IPV4/UDP/x.x.x.x/port”,RemoteAddress=“IPV4/UDP/x.x.x.x/port”,UsingPassword=“1”
[2017-02-07 13:34:32] SECURITY[22783] res_security_log.c: SecurityEvent=“SuccessfulAuth”,EventTV=“1486492356-471393”,Severity=“Informational”,Service=“AMI”,EventVersion=“1”,AccountID=“admin”,SessionID=“0x7f01fd624b08”,LocalAddress=“IPV4/TCP/0.0.0.0/5038”,RemoteAddress=“IPV4/TCP/127.0.0.1/37181”,UsingPassword=“0”,SessionTV=“1486492356-471389”
[2017-02-07 13:34:32] SECURITY[22783] res_security_log.c: SecurityEvent=“ChallengeSent”,EventTV=“1486492356-492812”,Severity=“Informational”,Service=“SIP”,EventVersion=“1”,AccountID=“194”,SessionID=“0x7f01f523d368”,LocalAddress=“IPV4/UDP/x.x.x.x/port”,RemoteAddress=“IPV4/UDP/x.x.x.x/port”,Challenge=“5094f75e”
Here are some logs from IP Phones as well the connectivity logs.
This is the response from one of my IP Phone.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=8ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Request timed out.
Request timed out.
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Request timed out.
Request timed out.
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Request timed out.
Request timed out.
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=8ms TTL=64
Reply from 172.16.17.199: bytes=32 time=8ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=118ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=8ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=8ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Request timed out.
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Reply from 172.16.17.199: bytes=32 time=10ms TTL=64
Reply from 172.16.17.199: bytes=32 time=9ms TTL=64
Ping statistics for 172.16.17.199:
Packets: Sent = 2880, Received = 2526, Lost = 354 (12% loss),
Approximate round trip times in milli-seconds:
Minimum = 5ms, Maximum = 3957ms, Average = 30ms
OK - where to start…
Your network is not nearly good enough to host a phone system. It’s barely good enough to host a cocktail party.
Because of that. your phone are registering and unregistering.
I’m a little concerned that this basic stuff is so hard for you to find. I’m sure there’s lots more problems, but for now, let’s just focus on the fact that your network is just dropping mare than 1 packet in 10. Fix that and get back to us.
I Have raised the issue with my network team and they said there is no issue at network level there might be issue at your server level sending broadcast or some junk traffic.
how can i check if my server is sending some broadcast or junk traffic.
Well, we’re done then. If your guys can’t interpret simple facts, then maybe you need new network guys. Until you get your infrastructure fixed, your phones are not going to work.
hey I am using cisco 7940 and i am getting rcv errors on the phones.
and on the same time I have another segment which is working fine without any issues.
tcpdump on the presented interface will show what traffic is being apparent , expect broadcast on the internal network, that would not appear outside your subnet ask your network guys how you should be subnetworking if they require that. then ask them how you should be routing traffic through what they gave you
hi dicko thanks for coming into this.
do you guys know any good ping tools to check the connectivity of ip phones addresses.
is this possible if any ip phone is malfunctioning it would create problem on the segment.
“ping” is never reliable it uses the icmp protocol , investigate connectivity on the protocol and port to the extensions you are using both to and from that extension and your server
man nmap
on which protocol. my phones are registered but sometimes when no response coming from the phones they go in lagged state and then unreachable and when they get response they are reachable.
I didn’t get the point “investigate connectivity on the protocol and port to the extensions you are using both to and from that extension and your server”
can you please explain this phrase.
Not really can I explain, if your network is broken and there is no response from an endpoint, you will need to fix that.
ok thanks.
let me check into this. see how can this issue be fixed and I will update here as it get resolved.
Pretty well always a network issue, it’s your network 
rasterisk -x 'sip show peers"
rasterisk -x “sip show peer nnnn”