Call on hold disconnecting after 90 sec

i have an issue with calls on hold disconnecting after 90 seconds. I suspect it has something to do with the fact there is no MOH so the line is silent but the RTP hold timeout is set to 500. My provider has stated it is definitely being disconnected at the PBX…

here is the log. can someone she a little light on where i may start looking?

[2019-04-26 12:11:51] VERBOSE[8290] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘77.108.132.8’
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] Set(“PJSIP/To-Brightstar-0000025e”, “__DIRECTION=INBOUND”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Gosub(“PJSIP/To-Brightstar-0000025e”, “sub-record-check,s,1(in,03301276352,dontcare)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/To-Brightstar-0000025e”, “0?initialized”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/To-Brightstar-0000025e”, “__REC_STATUS=INITIALIZED”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] Set(“PJSIP/To-Brightstar-0000025e”, “NOW=1556277111”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:4] Set(“PJSIP/To-Brightstar-0000025e”, “__DAY=26”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:5] Set(“PJSIP/To-Brightstar-0000025e”, “__MONTH=04”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/To-Brightstar-0000025e”, “__YEAR=2019”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/To-Brightstar-0000025e”, “__TIMESTR=20190426-121151”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/To-Brightstar-0000025e”, “__FROMEXTEN=unknown”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/To-Brightstar-0000025e”, “__MON_FMT=wav”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:10] NoOp(“PJSIP/To-Brightstar-0000025e”, “Recordings initialized”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/To-Brightstar-0000025e”, “0?Set(ARG3=dontcare)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:12] Set(“PJSIP/To-Brightstar-0000025e”, “REC_POLICY_MODE_SAVE=”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/To-Brightstar-0000025e”, “0?Set(REC_STATUS=NO)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:14] GotoIf(“PJSIP/To-Brightstar-0000025e”, “2?checkaction”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (sub-record-check,s,17)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/To-Brightstar-0000025e”, “1?sub-record-check,in,1”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (sub-record-check,in,1)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/To-Brightstar-0000025e”, “Inbound Recording Check to 03301276352”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/To-Brightstar-0000025e”, “FROMEXTEN=unknown”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/To-Brightstar-0000025e”, “11?Set(FROMEXTEN=03333442801)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:4] Gosub(“PJSIP/To-Brightstar-0000025e”, “recordcheck,1(dontcare,in,03301276352)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/To-Brightstar-0000025e”, “Starting recording check against dontcare”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Goto(“PJSIP/To-Brightstar-0000025e”, “dontcare”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] Return(“PJSIP/To-Brightstar-0000025e”, “”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:5] Return(“PJSIP/To-Brightstar-0000025e”, “”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] Set(“PJSIP/To-Brightstar-0000025e”, “CHANNEL(tonezone)=uk”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:4] Set(“PJSIP/To-Brightstar-0000025e”, “__FROM_DID=03301276352”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:5] Set(“PJSIP/To-Brightstar-0000025e”, “returnhere=1”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:6] Gosub(“PJSIP/To-Brightstar-0000025e”, “app-blacklist-check,s,1()”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/To-Brightstar-0000025e”, “0?blacklisted”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/To-Brightstar-0000025e”, “CALLED_BLACKLIST=1”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] Return(“PJSIP/To-Brightstar-0000025e”, “”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:7] Set(“PJSIP/To-Brightstar-0000025e”, “CDR(did)=03301276352”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:8] GotoIf(“PJSIP/To-Brightstar-0000025e”, “0?”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:9] ExecIf(“PJSIP/To-Brightstar-0000025e”, “0 ?Set(CALLERID(name)=03333442801)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:10] Set(“PJSIP/To-Brightstar-0000025e”, “CHANNEL(musicclass)=none”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:11] Set(“PJSIP/To-Brightstar-0000025e”, “__MOHCLASS=none”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:12] Set(“PJSIP/To-Brightstar-0000025e”, “__REVERSAL_REJECT=FALSE”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/To-Brightstar-0000025e”, “1?post-reverse-charge”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (from-pstn,03301276352,15)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:15] NoOp(“PJSIP/To-Brightstar-0000025e”, “”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:16] Set(“PJSIP/To-Brightstar-0000025e”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:17] Set(“PJSIP/To-Brightstar-0000025e”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:18] Set(“PJSIP/To-Brightstar-0000025e”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:19] Set(“PJSIP/To-Brightstar-0000025e”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:20] NoOp(“PJSIP/To-Brightstar-0000025e”, “CallerID Entry Point”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:21] Goto(“PJSIP/To-Brightstar-0000025e”, “ext-trunk,2,1”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (ext-trunk,2,1)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] Set(“PJSIP/To-Brightstar-0000025e”, “[email protected]_Link”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] Set(“PJSIP/To-Brightstar-0000025e”, “TDIAL_STRING=PJSIP”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:3] Set(“PJSIP/To-Brightstar-0000025e”, “DIAL_TRUNK=2”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:4] Goto(“PJSIP/To-Brightstar-0000025e”, “ext-trunk,tdial,1”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (ext-trunk,tdial,1)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:1] Set(“PJSIP/To-Brightstar-0000025e”, “OUTBOUND_GROUP=OUT_2”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:2] GotoIf(“PJSIP/To-Brightstar-0000025e”, “1?nomax”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx_builtins.c: Goto (ext-trunk,tdial,4)
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/To-Brightstar-0000025e”, “1?Set(CALLERPRES(name-pres)=allowed_not_screened)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:5] ExecIf(“PJSIP/To-Brightstar-0000025e”, “1?Set(CALLERPRES(num-pres)=allowed_not_screened)”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:6] Set(“PJSIP/To-Brightstar-0000025e”, “DIAL_NUMBER=03301276352”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:7] GosubIf(“PJSIP/To-Brightstar-0000025e”, “0?sub-flp-2,s,1()”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:8] Set(“PJSIP/To-Brightstar-0000025e”, “OUTNUM=03301276352”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:9] Set(“PJSIP/To-Brightstar-0000025e”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] pbx.c: Executing [[email protected]:10] Dial(“PJSIP/To-Brightstar-0000025e”, “PJSIP/[email protected]_Link,300,T”) in new stack
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] app_dial.c: Called PJSIP/[email protected]_Link
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] app_dial.c: PJSIP/SBC_Link-0000025f is making progress passing it to PJSIP/To-Brightstar-0000025e
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] app_dial.c: PJSIP/SBC_Link-0000025f is making progress passing it to PJSIP/To-Brightstar-0000025e
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] app_dial.c: PJSIP/SBC_Link-0000025f is ringing
[2019-04-26 12:11:51] VERBOSE[20693][C-0000012f] app_dial.c: PJSIP/SBC_Link-0000025f is ringing
[2019-04-26 12:11:59] VERBOSE[20693][C-0000012f] app_dial.c: PJSIP/SBC_Link-0000025f answered PJSIP/To-Brightstar-0000025e
[2019-04-26 12:11:59] VERBOSE[20701][C-0000012f] bridge_channel.c: Channel PJSIP/SBC_Link-0000025f joined ‘simple_bridge’ basic-bridge <bcdd1917-49ce-45da-ba93-a98ed1cffcfe>
[2019-04-26 12:11:59] VERBOSE[20693][C-0000012f] bridge_channel.c: Channel PJSIP/To-Brightstar-0000025e joined ‘simple_bridge’ basic-bridge <bcdd1917-49ce-45da-ba93-a98ed1cffcfe>
[2019-04-26 12:12:03] VERBOSE[20693][C-0000012f] res_musiconhold.c: Started music on hold, class ‘none’, on channel ‘PJSIP/To-Brightstar-0000025e’
[2019-04-26 12:12:03] WARNING[20693][C-0000012f] format_wav.c: Read failed (type)
[2019-04-26 12:12:03] WARNING[20693][C-0000012f] file.c: Unable to open format wav
[2019-04-26 12:12:03] WARNING[20693][C-0000012f] res_musiconhold.c: Unable to open file ‘/var/lib/asterisk/moh/.nomusic_reserved/silence’: No such file or directory
[2019-04-26 12:12:03] VERBOSE[20693][C-0000012f] res_musiconhold.c: Stopped music on hold on PJSIP/To-Brightstar-0000025e
[2019-04-26 12:13:33] VERBOSE[20693][C-0000012f] bridge_channel.c: Channel PJSIP/To-Brightstar-0000025e left ‘simple_bridge’ basic-bridge <bcdd1917-49ce-45da-ba93-a98ed1cffcfe>
[2019-04-26 12:13:33] VERBOSE[20693][C-0000012f] pbx.c: Spawn extension (ext-trunk, tdial, 10) exited non-zero on ‘PJSIP/To-Brightstar-0000025e’
[2019-04-26 12:13:33] VERBOSE[20701][C-0000012f] bridge_channel.c: Channel PJSIP/SBC_Link-0000025f left ‘simple_bridge’ basic-bridge <bcdd1917-49ce-45da-ba93-a98ed1cffcfe>

That’s why it doesn’t play. Make sure that the file exists in WAV format

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