[Home]

Summary:ASTERISK-26155: Error message pops up every few calls, call drop
Reporter:Private Name (falves11)Labels:pjsip
Date Opened:2016-06-27 09:12:23Date Closed:2020-01-14 11:13:36.000-0600
Priority:MajorRegression?
Status:Closed/CompleteComponents:Channels/chan_pjsip
Versions:13.9.1 Frequency of
Occurrence
Related
Issues:
Environment:Linux 64Attachments:( 0) 1523426524.229297
( 1) trace.txt
Description:This error comes up every few calls and the call drops.
[Jun 27 14:08:57] ERROR[10396]: channel.c:1278 ast_channel_by_name_cb: BUG! Must supply a channel name or partial name to match!
Comments:By: Asterisk Team (asteriskteam) 2016-06-27 09:12:24.605-0500

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.

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].
By: Joshua C. Colp (jcolp) 2016-06-27 09:15:02.539-0500

Thank you for taking the time to report this bug and helping to make Asterisk better. Unfortunately, we cannot work on this bug because your description did not include enough information. Please read over the Asterisk Issue Guidelines [1] which discusses the information necessary for your issue to be resolved and the format that information needs to be in. We would be grateful if you would then provide a more complete description of the problem. At a minimum, we need:

1. The specific steps or actions you took that caused you to encounter the problem.
2. The behavior you expected and the location of documentation that led you to that expectation.
3. The behavior you actually encountered.

To demonstrate the issue in detail, please include Asterisk log files generated per the instructions on the wiki [2]. If applicable, please ensure that protocol-level trace debugging is enabled, e.g., 'sip set debug on' if the issue involves chan_sip, and configuration information such as dialplan and channel configuration.

Thanks!

[1] https://wiki.asterisk.org/wiki/display/AST/Asterisk+Issue+Guidelines

[2] https://wiki.asterisk.org/wiki/display/AST/Collecting+Debug+Information


By: Private Name (falves11) 2016-06-27 09:30:46.008-0500

This did not happen with Asterisk 12. I upgraded to Asterisk 13.9.1, certified, last night. The same 3 clients are sending traffic.
Please let me know how can I trace the source of this error. I receive many calls per second, so setting a debug level is not possible.
The version of PJSIP did not change. The only change in pjsip.conf was adding rtp_timeout=30 to the endpoints.


By: Joshua C. Colp (jcolp) 2016-06-27 09:34:04.057-0500

What I've asked for is what is needed. There's nothing that can be done with the brief description you've provided.
By: Private Name (falves11) 2016-06-27 09:35:40.768-0500

Please close the case.
By: Joshua C. Colp (jcolp) 2016-06-27 09:43:33.727-0500

Suspended per reporter's request.
By: Private Name (falves11) 2016-06-28 13:34:01.856-0500

I am reopening the case and uploading a trace. It is an extract from the full file, showing the previous 10 and following 10 lines after the word Error.
The most curious thing I found is:
chan_pjsip.c: AST hangup cause 16 (no match found in PJSIP)
Which I think is a bug on its own, since I hangup with plain Hangup()
By: Asterisk Team (asteriskteam) 2016-06-28 13:34:02.164-0500

This issue has been reopened as a result of your commenting on it as the reporter. It will be triaged once again as applicable.
By: shaurya jain (shaurya) 2018-03-15 07:57:23.429-0500

Dear Team,

I am experiencing same issue after upgrading to 15.2.0.

Please find the below DEBUG logs,and let me know the proceedings.


[Mar 14 23:20:23] DEBUG[25018] res_http_websocket.c: Writing websocket string of length 667
[Mar 14 23:20:23] DEBUG[25018] res_http_websocket.c: Writing websocket text frame, length 667
[Mar 14 23:20:23] DEBUG[11099][C-00001eee] stasis/app.c: Bridge '2015' is 12 interested in agent-dial
[Mar 14 23:20:23] DEBUG[11278] http.c: HTTP keeping session open.  status_code:204
[Mar 14 23:20:23] DEBUG[11208] audiohook.c: Read factory 0x7f8464007188 and write factory 0x7f8464007bc8 both fail to provide 160 samples
[Mar 14 23:20:23] DEBUG[11208] audiohook.c: Read factory 0x7f8464007188 was pretty quick last time, waiting for them.
[Mar 14 23:20:23] DEBUG[11278] http.c: HTTP Request URI is /ari/channels/create?endpoint=PJSIP/2015&app=agent-dial&appArgs=accountCode-agentExten_2015,timeout-10
[Mar 14 23:20:23] DEBUG[11278] http.c: match request [ari/channels/create] with handler [httpstatus] len 10
[Mar 14 23:20:23] DEBUG[11278] http.c: match request [ari/channels/create] with handler [phoneprov] len 9
[Mar 14 23:20:23] DEBUG[11278] http.c: match request [ari/channels/create] with handler [static] len 6
[Mar 14 23:20:23] DEBUG[11278] http.c: match request [ari/channels/create] with handler [ari] len 3
[Mar 14 23:20:23] DEBUG[11278] http.c: Match made with [ari]
[Mar 14 23:20:23] DEBUG[11278] res_ari.c: Finding handler for channels
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking applications
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking bridges
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking sounds
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking recordings
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking endpoints
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking asterisk
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking events
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking playbacks
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking deviceStates
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking channels
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Got it!
[Mar 14 23:20:23] DEBUG[11278] res_ari.c: Finding handler for create
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Checking create
[Mar 14 23:20:23] DEBUG[11278] res_ari.c:   Got it!
[Mar 14 23:20:23] ERROR[11278] channel.c: BUG! Must supply a channel name or partial name to match!




[Mar 14 23:20:23] DEBUG[11288] http.c: HTTP Request URI is /ari/channels/1521049823.19603/dial?timeout=10
[Mar 14 23:20:23] DEBUG[11288] http.c: match request [ari/channels/1521049823.19603/dial] with handler [httpstatus] len 10
[Mar 14 23:20:23] DEBUG[11288] http.c: match request [ari/channels/1521049823.19603/dial] with handler [phoneprov] len 9
[Mar 14 23:20:23] DEBUG[11288] http.c: match request [ari/channels/1521049823.19603/dial] with handler [static] len 6
[Mar 14 23:20:23] DEBUG[11288] http.c: match request [ari/channels/1521049823.19603/dial] with handler [ari] len 3
[Mar 14 23:20:23] DEBUG[11288] http.c: Match made with [ari]
[Mar 14 23:20:23] DEBUG[11288] res_ari.c: Finding handler for channels
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking applications
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking bridges
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking sounds
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking recordings
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking endpoints
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking asterisk
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking events
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking playbacks
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking deviceStates
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking channels
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Got it!
[Mar 14 23:20:23] DEBUG[11288] res_ari.c: Finding handler for 1521049823.19603
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking create
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking channelId
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Got it!
[Mar 14 23:20:23] DEBUG[11288] res_ari.c: Finding handler for dial
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking continue
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking redirect
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking answer
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking ring
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking dtmf
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking mute
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking hold
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking moh
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking silence
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking play
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking record
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking variable
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking snoop
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Checking dial
[Mar 14 23:20:23] DEBUG[11288] res_ari.c:   Got it!
[Mar 14 23:20:23] ERROR[11288] channel.c: BUG! Must supply a channel name or partial name to match!
:

By: shaurya jain (shaurya) 2018-03-19 04:20:32.209-0500

Dear Team,

Any update?

Or i should open a separate case.

By: Joshua C. Colp (jcolp) 2018-03-19 05:03:54.744-0500

Any updates will be posted to this issue if there are any. Asking for an update won't produce anything extra.
By: Joshua C. Colp (jcolp) 2018-03-19 05:29:28.556-0500

This did not get triaged until now but the additional information I originally requested is needed.
By: Joshua C. Colp (jcolp) 2018-03-19 05:30:06.232-0500

[~shaurya] If you want to open a new issue you can, they are likely different underlying issues. We will need full information though - traces of the HTTP requests themselves, full console output, information about how you're using ARI.
By: Asterisk Team (asteriskteam) 2018-04-02 12:00:00.444-0500

Suspended due to lack of activity. This issue will be automatically re-opened if the reporter posts a comment. If you are not the reporter and would like this re-opened please create a new issue instead. If the new issue is related to this one a link will be created during the triage process. Further information on issue tracker usage can be found in the Asterisk Issue Guidlines [1].

[1] https://wiki.asterisk.org/wiki/display/AST/Asterisk+Issue+Guidelines
By: shaurya jain (shaurya) 2018-04-11 02:58:01.013-0500

Hi Joshua Colp ,

We are still facing the concern although there is no call disconnection or major issue regarding this but it leads to unwanted ERRORS on console.

[Apr 11 14:02:23] NOTICE[32364][C-00011eaa] res_stasis_playback.c: 1523426524.229297: Playback stopped for sound:11/mixivr
[Apr 11 14:02:24] ERROR[32444] channel.c: BUG! Must supply a channel name or partial name to match!
[Apr 11 14:02:24] ERROR[32623] channel.c: BUG! Must supply a channel name or partial name to match!

Attached are the ARI logs as you asked in previous note which can show you the exact ARI request and call flow.


Let me know the proceedings in this regards.


By: shaurya jain (shaurya) 2018-04-11 02:58:23.282-0500

ARI LOGS