Excessive PJSIP Registrar errors in Log

I’m currently setting up a hosted freepbx with Freepbxhosting. I’m using Polycom VVX 310, VVX 410 and VVX 500 phones. I’m new to the telecom world, but I’ve been learning a lot as I’ve been working on getting this working. The system is “working”, but I’ve noticed a few strange things like queue extensions not ringing until the first “your call is now first in line…” IVR announcement is finished. But yet other extensions of the queue would be ringing fine. I use FOP2 to give me a graphical view of the extensions. I noticed in FOP2 that about every 2 minutes the extensions (randomly not all at once) would go “grey” for about 2 seconds and then come back on green and active. I looked in the Asterisk Log file and noticed thousands of lines of the following errors for each extension. I’ve Googled around and tried a few things like upping the time of the UDP timeout in the router, but the errors seem to be happening just as frequently. Any suggestions? We are using a Cisco RV320 router and FreePBX 14. Here is an example of the log file for just one of the extensions. All the extensions have the same errors (I’ve xxx’d out our IP address):

[2019-03-07 12:16:01] VERBOSE[24757] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:5060 is now Reachable. RTT: 54.318 msec
[2019-03-07 12:16:55] VERBOSE[24757] res_pjsip_registrar.c: Added contact ‘sip:[email protected]:36320’ to AOR ‘107’ with expiration of 120 seconds
[2019-03-07 12:16:55] VERBOSE[24757] res_pjsip_registrar.c: Removed contact ‘sip:[email protected]:5060’ from AOR ‘107’ due to remove_existing
[2019-03-07 12:16:55] VERBOSE[6500] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:5060 has been deleted
[2019-03-07 12:16:55] VERBOSE[6500] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Unreachable
[2019-03-07 12:17:01] VERBOSE[15960] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Reachable
[2019-03-07 12:17:01] VERBOSE[15960] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:36320 is now Reachable. RTT: 56.184 msec
[2019-03-07 12:17:55] VERBOSE[24757] res_pjsip_registrar.c: Added contact ‘sip:[email protected]:5060’ to AOR ‘107’ with expiration of 120 seconds
[2019-03-07 12:17:55] VERBOSE[24757] res_pjsip_registrar.c: Removed contact ‘sip:[email protected]:36320’ from AOR ‘107’ due to remove_existing
[2019-03-07 12:17:55] VERBOSE[12075] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:36320 has been deleted
[2019-03-07 12:17:55] VERBOSE[12075] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Unreachable
[2019-03-07 12:18:01] VERBOSE[15960] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Reachable
[2019-03-07 12:18:01] VERBOSE[15960] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:5060 is now Reachable. RTT: 57.087 msec
[2019-03-07 12:18:55] VERBOSE[15960] res_pjsip_registrar.c: Added contact ‘sip:[email protected]:36347’ to AOR ‘107’ with expiration of 120 seconds
[2019-03-07 12:18:55] VERBOSE[15960] res_pjsip_registrar.c: Removed contact ‘sip:[email protected]:5060’ from AOR ‘107’ due to remove_existing
[2019-03-07 12:18:55] VERBOSE[6500] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:5060 has been deleted
[2019-03-07 12:18:55] VERBOSE[6500] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Unreachable
[2019-03-07 12:19:01] VERBOSE[15960] res_pjsip/pjsip_configuration.c: Endpoint 107 is now Reachable
[2019-03-07 12:19:01] VERBOSE[15960] res_pjsip/pjsip_options.c: Contact 107/sip:[email protected]:36347 is now Reachable. RTT: 52.316 msec

Thanks for any suggestions or help.
Scrandall

***** Update ******

Strangely enough, we had a power outage in our area which cause our router to reboot…which seems to have fixed the problem. Maybe after upping the UDP timeout option I needed to reboot the router. Looks like things are going fine now.

1 Like

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.