[Home]

Summary:ASTERISK-29231: pjsip: SIGSEGV in CLI if no trunk is registered
Reporter:Michael Maier (micha)Labels:
Date Opened:2021-01-03 02:54:07.000-0600Date Closed:2021-01-11 09:28:14.000-0600
Priority:MajorRegression?
Status:Closed/CompleteComponents:Resources/res_pjsip_outbound_registration
Versions:18.1.0 Frequency of
Occurrence
Related
Issues:
Environment:CentOS 7 x86_64Attachments:
Description:Asterisk segfaults on CLI if the following command is entered and no registration exists:

pjsip show registrations all

Backtrace:
{code}
Thread 1 (Thread 0x7ff44c816700 (LWP 2437)):
#0  0x00007ff48619b1c0 in cli_print_body (obj=0x3761b78, arg=0x7ff44c815200, flags=2) at res_pjsip_outbound_registration.c:2297
       registration = 0x3761b78
       context = 0x7ff44c815200
       id = 0x376c3f0 "easybellPJSIP"
       state = 0x0
       next_run_ms = 0
       next = {tv_sec = 0, tv_usec = 0}
       last = {tv_sec = 0, tv_usec = 0}
       tm = {tm_sec = 0, tm_min = 0, tm_hour = -2147479896, tm_mday = 32755, tm_mon = 1283542976, tm_year = 32756, tm_wday = 0, tm_yday = 0, tm_isdst = 512000, tm_gmtoff = 0, tm_zone = 0x100000002 <Address 0x100000002 out of bounds>, tm_usec = -2147479808}
       next_start = '000' <repeats 31 times>
       last_start = '000' <repeats 31 times>
       interval = 32755
       __PRETTY_FUNCTION__ = "cli_print_body"
{code}

res_pjsip_outbound_registration.c:2297 is:
if (state->client_state->sched_task) {

How to reproduce:
{code}
virtast*CLI> pjsip show registrations

<Registration/ServerURI..............................>  <Auth..........>  <Status.......>  <Last Reg..>  <Intvl>  <Next Start.....secs>
========================================================================================================================================

easybellPJSIP/sip:secure.sip.easybell.de                easybellPJSIP     Registered       Sun 09:29:33       80  Sun 09:30:53       58

Objects found: 1

[2021-01-03 09:29:57] DEBUG[2397]: res_pjsip_registrar.c:1293 check_expiration_thread: Expiring 0 contacts
virtast*CLI> pjsip send unregister *all
Unregister all queued
[2021-01-03 09:30:02] DEBUG[2437]: res_pjsip_outbound_registration.c:1263 sip_outbound_registration_state_destroy: easybellPJSIP: Destroying registration state for registration to server 'sip:secure.sip.easybell.de' from client 'sip:004912345678901@secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:776 handle_client_state_destruction: easybellPJSIP: Trying to unregister with server 'sip:secure.sip.easybell.de' from client 'sip:004912345678901@secure.sip.easybell.de' before destruction.
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:479 sip_resolve: Performing SIP DNS resolution of target 'secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:506 sip_resolve: Transport type for target 'secure.sip.easybell.de' is 'TLS transport'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:549 sip_resolve: [0x7ff444300d58] Created resolution tracking for target 'secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7ff444300d58] Added target 'secure.sip.easybell.de' with record type '35', transport 'TLS transport', and port '5061'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7ff444300d58] Added target '_sips._tcp.secure.sip.easybell.de' with record type '33', transport 'TLS transport', and port '5061'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7ff444300d58] Added target 'secure.sip.easybell.de' with record type '1', transport 'TLS transport', and port '5061'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:620 sip_resolve: [0x7ff444300d58] Starting initial resolution using parallel queries for target 'secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2396]: res_pjsip/pjsip_resolver.c:277 sip_resolve_callback: [0x7ff444300d58] All parallel queries completed
[2021-01-03 09:30:02] DEBUG[2396]: res_pjsip/pjsip_resolver.c:326 sip_resolve_callback: [0x7ff444300d58] A record received on target 'secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2396]: res_pjsip/pjsip_resolver.c:421 sip_resolve_callback: [0x7ff444300d58] Resolution completed - 1 viable targets
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:201 sip_resolve_invoke_user_callback: [0x7ff444300d58] Address '0' is 212.172.58.207:5061 with transport 'TLS transport'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_resolver.c:207 sip_resolve_invoke_user_callback: [0x7ff444300d58] Invoking user callback with '1' addresses
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:520 distributor: No dialog serializer for Response msg 401/REGISTER/cseq=18419 (rdata0x7ff4442ef028).  Using request transaction as basis.
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:128 find_request_serializer: Found transaction tsx0x7ff444322128 for Response msg 401/REGISTER/cseq=18419 (rdata0x7ff4442ef028).
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:138 find_request_serializer: Found serializer pjsip/outreg/easybellPJSIP-00000063 on transaction tsx0x7ff444322128
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1214 sip_outbound_registration_response_cb: easybellPJSIP: Received REGISTER response 401(Unauthorized) from 'sip:secure.sip.easybell.de': Expires: 0
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1039 handle_registration_response: easybellPJSIP: Processing REGISTER response 401 from server 'sip:secure.sip.easybell.de' for client 'sip:004912345678901@secure.sip.easybell.de' with expiration '0'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1063 handle_registration_response: easybellPJSIP: Sending authenticated REGISTER to server 'sip:secure.sip.easybell.de' from client 'sip:004912345678901@secure.sip.easybell.de'
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:520 distributor: No dialog serializer for Response msg 200/REGISTER/cseq=18420 (rdata0x7ff4442ef028).  Using request transaction as basis.
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:128 find_request_serializer: Found transaction tsx0x7ff44400ada8 for Response msg 200/REGISTER/cseq=18420 (rdata0x7ff4442ef028).
[2021-01-03 09:30:02] DEBUG[2385]: res_pjsip/pjsip_distributor.c:138 find_request_serializer: Found serializer pjsip/outreg/easybellPJSIP-00000063 on transaction tsx0x7ff44400ada8
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1214 sip_outbound_registration_response_cb: easybellPJSIP: Received REGISTER response 200(OK) from 'sip:secure.sip.easybell.de': Expires: 0
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1039 handle_registration_response: easybellPJSIP: Processing REGISTER response 200 from server 'sip:secure.sip.easybell.de' for client 'sip:004912345678901@secure.sip.easybell.de' with expiration '0'
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1110 handle_registration_response: easybellPJSIP: Outbound unregistration to 'sip:secure.sip.easybell.de' with client 'sip:004912345678901@secure.sip.easybell.de' successful
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7ff486196129(0x7ff444006188) from transport tlsc0x7ff4442eed38
[2021-01-03 09:30:02] DEBUG[2386]: res_pjsip_outbound_registration.c:1284 sip_outbound_registration_client_state_destroy: easybellPJSIP: Destroying registration client state
virtast*CLI> pjsip show registrations
virtast*CLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups
{code}
Comments:By: Asterisk Team (asteriskteam) 2021-01-03 02:54:10.401-0600

Thanks for creating a report! The issue has entered the triage process. That means the issue will wait in this status until a Bug Marshal has an opportunity to review the issue. Once the issue has been reviewed you will receive comments regarding the next steps towards resolution. Please note that log messages and other files should not be sent to the Sangoma Asterisk Team unless explicitly asked for. All files should be placed on this issue in a sanitized fashion as needed.

A good first step is for you to review the [Asterisk Issue Guidelines|https://wiki.asterisk.org/wiki/display/AST/Asterisk+Issue+Guidelines] if you haven't already. The guidelines detail what is expected from an Asterisk issue report.

Then, if you are submitting a patch, please review the [Patch Contribution Process|https://wiki.asterisk.org/wiki/display/AST/Patch+Contribution+Process].

Please note that once your issue enters an open state it has been accepted. As Asterisk is an open source project there is no guarantee or timeframe on when your issue will be looked into. If you need expedient resolution you will need to find and pay a suitable developer. Asking for an update on your issue will not yield any progress on it and will not result in a response. All updates are posted to the issue when they occur.

Please note that by submitting data, code, or documentation to Sangoma through JIRA, you accept the Terms of Use present at [https://www.asterisk.org/terms-of-use/|https://www.asterisk.org/terms-of-use/].

By: George Joseph (gjoseph) 2021-01-04 07:23:25.014-0600

I can reproduce the issue.


By: Michael Maier (micha) 2021-01-06 04:28:41.214-0600

One more thing: If you do a "pjsip send unregister *all" and afterwards try to register again based on the name of the configured account, it won't work. You have to restart the registration via "pjsip send register *all" to do a new registration.

{code}
virtast*CLI> pjsip show registrations

<Registration/ServerURI..............................>  <Auth..........>  <Status.......>  <Last Reg..>  <Intvl>  <Next Start.....secs>
========================================================================================================================================

easybellPJSIP/sip:secure.sip.easybell.de                easybellPJSIP     Registered       Wed 11:10:26       80  Wed 11:11:46       64

Objects found: 1

[2021-01-06 11:10:52] DEBUG[1400]: res_pjsip_registrar.c:1293 check_expiration_thread: Expiring 0 contacts
virtast*CLI> pjsip send unregister *all
Unregister all queued
[2021-01-06 11:11:02] DEBUG[3824]: res_pjsip_outbound_registration.c:1332 sip_outbound_registration_state_destroy: easybellPJSIP: Destroying registration state for registration to server 'sip:secure.sip.easybell.de' from client 'sip:004912345678999@secure.sip.easybell.de'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:804 handle_client_state_destruction: easybellPJSIP: Trying to unregister with server 'sip:secure.sip.easybell.de' from client 'sip:004912345678999@secure.sip.easybell.de' before destruction.
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:479 sip_resolve: Performing SIP DNS resolution of target 'secure.sip.easybell.de'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:506 sip_resolve: Transport type for target 'secure.sip.easybell.de' is 'TLS transport'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:549 sip_resolve: [0x7f84c402dc28] Created resolution tracking for target 'secure.sip.easybell.de'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7f84c402dc28] Added target 'secure.sip.easybell.de' with record type '35', transport 'TLS transport', and port '5061'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7f84c402dc28] Added target '_sips._tcp.secure.sip.easybell.de' with record type '33', transport 'TLS transport', and port '5061'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:177 sip_resolve_add: [0x7f84c402dc28] Added target 'secure.sip.easybell.de' with record type '1', transport 'TLS transport', and port '5061'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:620 sip_resolve: [0x7f84c402dc28] Starting initial resolution using parallel queries for target 'secure.sip.easybell.de'
[2021-01-06 11:11:02] DEBUG[1399]: res_pjsip/pjsip_resolver.c:277 sip_resolve_callback: [0x7f84c402dc28] All parallel queries completed
[2021-01-06 11:11:02] DEBUG[1399]: res_pjsip/pjsip_resolver.c:326 sip_resolve_callback: [0x7f84c402dc28] A record received on target 'secure.sip.easybell.de'
[2021-01-06 11:11:02] DEBUG[1399]: res_pjsip/pjsip_resolver.c:421 sip_resolve_callback: [0x7f84c402dc28] Resolution completed - 1 viable targets
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:201 sip_resolve_invoke_user_callback: [0x7f84c402dc28] Address '0' is 212.172.58.207:5061 with transport 'TLS transport'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_resolver.c:207 sip_resolve_invoke_user_callback: [0x7f84c402dc28] Invoking user callback with '1' addresses
<--- Transmitting SIP request (529 bytes) to TLS:212.172.58.207:5061 --->
REGISTER sip:secure.sip.easybell.de SIP/2.0
Via: SIP/2.0/TLS 192.168.122.174:5061;rport;branch=z9hG4bKPj94aa9ad4-6cc7-4f91-89a7-cca30fd5414f;alias
From: <sip:004912345678999@secure.sip.easybell.de>;tag=3cd33501-6da8-43bd-af8c-5f4457dc9527
To: <sip:004912345678999@secure.sip.easybell.de>
Call-ID: 508cbd08-e53a-4f08-9af9-d88ef8c27200
CSeq: 41128 REGISTER
Contact: <sip:+4912345678999@192.168.122.174:5061;transport=TLS;line=rvnrkbl>
Expires: 0
Max-Forwards: 70
User-Agent: FPBX-15.0.16.75(18.1.1)
Content-Length:  0


<--- Received SIP response (636 bytes) from TLS:212.172.58.207:5061 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/TLS 192.168.122.174:5061;rport=46396;branch=z9hG4bKPj94aa9ad4-6cc7-4f91-89a7-cca30fd5414f;alias;received=93.235.1.55
From: <sip:004912345678999@secure.sip.easybell.de>;tag=3cd33501-6da8-43bd-af8c-5f4457dc9527
To: <sip:004912345678999@secure.sip.easybell.de>;tag=95c37a12bff1a2c36d72bf8333176544.7855
Call-ID: 508cbd08-e53a-4f08-9af9-d88ef8c27200
CSeq: 41128 REGISTER
P-NGCP-Auth-IP: 192.168.251.60
P-NGCP-Auth-UA: FPBX-15.0.16.75(18.1.1)
WWW-Authenticate: Digest realm="secure.sip.easybell.de", nonce="."
Server: Sipwise NGCP Proxy 7.X
Content-Length: 0


[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:520 distributor: No dialog serializer for Response msg 401/REGISTER/cseq=41128 (rdata0x7f84d42ef888).  Using request transaction as basis.
[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:128 find_request_serializer: Found transaction tsx0x7f84d400acd8 for Response msg 401/REGISTER/cseq=41128 (rdata0x7f84d42ef888).
[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:138 find_request_serializer: Found serializer pjsip/outreg/easybellPJSIP-00000070 on transaction tsx0x7f84d400acd8
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1283 sip_outbound_registration_response_cb: easybellPJSIP: Received REGISTER response 401(Unauthorized) from 'sip:secure.sip.easybell.de': Expires: 0
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1067 handle_registration_response: easybellPJSIP: Processing REGISTER response 401 from server 'sip:secure.sip.easybell.de' for client 'sip:004912345678999@secure.sip.easybell.de' with expiration '0'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1091 handle_registration_response: easybellPJSIP: Sending authenticated REGISTER to server 'sip:secure.sip.easybell.de' from client 'sip:004912345678999@secure.sip.easybell.de'
<--- Transmitting SIP request (732 bytes) to TLS:212.172.58.207:5061 --->
REGISTER sip:secure.sip.easybell.de SIP/2.0
Via: SIP/2.0/TLS 192.168.122.174:5061;rport;branch=z9hG4bKPj8abb7baf-96a0-4ce7-85d7-11304a23f01c;alias
From: <sip:004912345678999@secure.sip.easybell.de>;tag=3cd33501-6da8-43bd-af8c-5f4457dc9527
To: <sip:004912345678999@secure.sip.easybell.de>
Call-ID: 508cbd08-e53a-4f08-9af9-d88ef8c27200
CSeq: 41129 REGISTER
Contact: <sip:+4912345678999@192.168.122.174:5061;transport=TLS;line=rvnrkbl>
Expires: 0
Max-Forwards: 70
User-Agent: FPBX-15.0.16.75(18.1.1)
Authorization: Digest username="004912345678999", realm="secure.sip.easybell.de", nonce=".", uri="sip:secure.sip.easybell.de", response="."
Content-Length:  0


<--- Received SIP response (527 bytes) from TLS:212.172.58.207:5061 --->
SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.122.174:5061;rport=46396;branch=z9hG4bKPj8abb7baf-96a0-4ce7-85d7-11304a23f01c;alias;received=93.235.1.55
From: <sip:004912345678999@secure.sip.easybell.de>;tag=3cd33501-6da8-43bd-af8c-5f4457dc9527
To: <sip:004912345678999@secure.sip.easybell.de>;tag=95c37a12bff1a2c36d72bf8333176544.7855
Call-ID: 508cbd08-e53a-4f08-9af9-d88ef8c27200
CSeq: 41129 REGISTER
P-NGCP-Auth-IP: 192.168.251.60
P-NGCP-Auth-UA: FPBX-15.0.16.75(18.1.1)
Server: Sipwise NGCP Proxy 7.X
Content-Length: 0


[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:520 distributor: No dialog serializer for Response msg 200/REGISTER/cseq=41129 (rdata0x7f84d42ef888).  Using request transaction as basis.
[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:128 find_request_serializer: Found transaction tsx0x7f84d4322198 for Response msg 200/REGISTER/cseq=41129 (rdata0x7f84d42ef888).
[2021-01-06 11:11:02] DEBUG[1386]: res_pjsip/pjsip_distributor.c:138 find_request_serializer: Found serializer pjsip/outreg/easybellPJSIP-00000070 on transaction tsx0x7f84d4322198
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1283 sip_outbound_registration_response_cb: easybellPJSIP: Received REGISTER response 200(OK) from 'sip:secure.sip.easybell.de': Expires: 0
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1067 handle_registration_response: easybellPJSIP: Processing REGISTER response 200 from server 'sip:secure.sip.easybell.de' for client 'sip:004912345678999@secure.sip.easybell.de' with expiration '0'
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1162 handle_registration_response: easybellPJSIP: Outbound unregistration to 'sip:secure.sip.easybell.de' with client 'sip:004912345678999@secure.sip.easybell.de' successful
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c402c3b8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4007c48) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4000a48) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4000a18) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d430c158) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d40093d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d42edca8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d000f398) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d000a3d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d00065a8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d000d0f8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d000e568) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d0005f38) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d42edc78) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4009428) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d42ed138) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d42ed168) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4006ef8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d430be58) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4307718) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4300158) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4007bd8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4300128) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4006e08) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d00142a8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4008ff8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4009048) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d430d1a8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4008b38) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4008b08) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d430d1d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4000b28) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4006d78) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4006da8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4307748) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d400a878) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d400d3b8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d430b528) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d42ed1e8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d40081e8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d40009b8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d43001d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84d4008a88) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4006e28) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c40071d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4002918) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4001498) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4002fc8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4000ae8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4003018) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c40074f8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4001098) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c402c748) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4007528) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4000c78) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4003068) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4003098) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4002cf8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4001468) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c0001958) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c0002798) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001c78) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8002138) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001cc8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c80058d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8002598) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8005698) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8005548) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8000bc8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001be8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001678) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c80008d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001648) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8004d38) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8005928) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8002928) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8000908) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c80059d8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c4001558) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84bc0015e8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8001c48) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c8005138) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip/pjsip_transport_events.c:246 transport_monitor_unregister_cb: Unregistered monitor 0x7f8516f0a226(0x7f84c80026c8) from transport tlsc0x7f84d42ef598
[2021-01-06 11:11:02] DEBUG[3825]: res_pjsip_outbound_registration.c:1353 sip_outbound_registration_client_state_destroy: easybellPJSIP: Destroying registration client state
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI>
virtast*CLI> pjsip send register
*all           easybellPJSIP  
[2021-01-06 11:11:22] DEBUG[1400]: res_pjsip_registrar.c:1293 check_expiration_thread: Expiring 0 contacts
[2021-01-06 11:11:26] DEBUG[3826]: threadpool.c:1169 worker_idle: Worker thread idle timeout reached. Dying.
[2021-01-06 11:11:26] DEBUG[3828]: threadpool.c:1169 worker_idle: Worker thread idle timeout reached. Dying.
[2021-01-06 11:11:26] DEBUG[1384]: threadpool.c:1028 worker_thread_destroy: Destroying worker thread 830
[2021-01-06 11:11:26] DEBUG[3829]: threadpool.c:1169 worker_idle: Worker thread idle timeout reached. Dying.
[2021-01-06 11:11:26] DEBUG[3827]: threadpool.c:1169 worker_idle: Worker thread idle timeout reached. Dying.
[2021-01-06 11:11:26] DEBUG[1384]: threadpool.c:1028 worker_thread_destroy: Destroying worker thread 832
[2021-01-06 11:11:26] DEBUG[1384]: threadpool.c:1028 worker_thread_destroy: Destroying worker thread 833
[2021-01-06 11:11:26] DEBUG[1384]: threadpool.c:1028 worker_thread_destroy: Destroying worker thread 831
virtast*CLI> pjsip send register easybellPJSIP
Unable to retrieve registration easybellPJSIP
Command 'pjsip send register easybellPJSIP' failed.
virtast*CLI> pjsip send register easybellPJSIP
Unable to retrieve registration easybellPJSIP
Command 'pjsip send register easybellPJSIP ' failed.
{code}

BTW: is it supposed that there are so much monitors to be removed?


By: George Joseph (gjoseph) 2021-01-06 09:29:38.754-0600

bq. BTW: is it supposed that there are so much monitors to be removed?

Hmmm.  I'll look at that as well.


By: Michael Maier (micha) 2021-01-07 02:46:57.573-0600

Just for the record: Problem can't be reproduced with 18.0.1.

By: Friendly Automation (friendly-automation) 2021-01-11 09:28:15.495-0600

Change 15292 merged by Friendly Automation:
Revert "res_pjsip_outbound_registration.c:  Use our own scheduler and other stuff"

[https://gerrit.asterisk.org/c/asterisk/+/15292|https://gerrit.asterisk.org/c/asterisk/+/15292]

By: Friendly Automation (friendly-automation) 2021-01-11 09:28:49.027-0600

Change 15290 merged by Friendly Automation:
Revert "res_pjsip_outbound_registration.c:  Use our own scheduler and other stuff"

[https://gerrit.asterisk.org/c/asterisk/+/15290|https://gerrit.asterisk.org/c/asterisk/+/15290]

By: Friendly Automation (friendly-automation) 2021-01-11 09:30:29.635-0600

Change 15291 merged by Joshua Colp:
Revert "res_pjsip_outbound_registration.c:  Use our own scheduler and other stuff"

[https://gerrit.asterisk.org/c/asterisk/+/15291|https://gerrit.asterisk.org/c/asterisk/+/15291]