All Calls are ended after 32 seconds

freepbxisking · February 13, 2022, 6:32pm

Hi all,

I have just setup a new install this week and all my inbound calls hangup after about 30 to 32 seconds every single time without feel even if you put the collar on hold after answering the call. I have a logged what has been happening below, I do have the Basic knowledge on how to fix most thing in freepbx, but this absolutely head scratching problem has me bamboozled.

Can someone help me or send me pointing me in the right direction is there something I’m overlooking or missing. I have not done anything to the freepbx server at this point and i know this will not go down well with some, so no updates nothing not even registration complete clean install, and this issue also seems to happen on a clean install with updates and registration. So I really do not know what the problem is at this point that is causing this issue.

I have looked at the wiki that has says that the error, maybe with firewall, but that did not help as could not see anything obvious that could be the issue I also checked other logs with an Asterix sep setup debug enabled and still did not reveal what was going on.

Based on another post with a similar issue I have looked at the mentioned ports IP addresses and ISP but none of this has changed I also have a permanent fix IP address and nothing has been changed in the ISP router I am hoping that someone can help me.

Spawn extension (ext-queues, 700, 52) exited non-zero on ‘PJSIP/voip-00000031’
– Executing [h@ext-queues:1] Macro (" PJSIP/voip-00000031 ", " hangupcall, “) in new stack
– Executing [s@macro-hangupcall:1] GotoIf (” PJSIP/voip-00000031 ", " 1?theend “) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf (” PJSIP/voip-00000031 ", " 0?Set(CDR(recordingfile)=) “) in new stack
– Executing [s@macro-hangupcall:4] NoOp (” PJSIP/voip-00000031 ", " Local/8001@from-queue-0000006d;1 montior file= “) in new stack
– Executing [s@macro-hangupcall:5] GotoIf (” PJSIP/voip-00000031 ", " 1?skipagi “) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] Hangup (” PJSIP/voip-00000031 “, “”) in new stack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/voip-00000031’ in macro ‘hangupcall’
== Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/voip-00000031’
– PJSIP/twillo-00000031 Internal Gosub(crm-hangup,s,1) start
– Executing [s@crm-hangup:1] NoOp (” PJSIP/voip-00000031 ", " Sending Hangup to CRM “) in new stack
– Executing [s@crm-hangup:2] NoOp (” PJSIP/voip-00000031 ", " HANGUP CAUSE: 18 “) in new stack
– Executing [s@crm-hangup:3] ExecIf (” PJSIP/voip-00000031 ", " 0?Set(__CRM_VOICEMAIL=) “) in new stack
– Executing [s@crm-hangup:4] NoOp (” PJSIP/voip-00000031 ", " MASTER CHANNEL: 1644776563.267 = 1644776563.267 “) in new stack
– Executing [s@crm-hangup:5] GotoIf (” PJSIP/voip-00000031 ", " 0?return “) in new stack
– Executing [s@crm-hangup:6] Set (” PJSIP/voip-00000031 ", " __CRM_HANGUP=1 “) in new stack
– Executing [s@crm-hangup:7] AGI (” PJSIP/voip-00000031 ", " agi://127.0.0.1/sangomacrm.agi “) in new stack
– Stopped music on hold on Local/8001@from-queue-0000006d;2
– Channel Local/8001@from-queue-0000006d;2 left ‘simple_bridge’ basic-bridge <5a8f2dac-ecd5-46de-af4c-5069b2dba0ba>
== Spawn extension (macro-dial-one, s, 56) exited non-zero on ‘Local/8001@from-queue-0000006d;2’ in macro ‘dial-one’
== Spawn extension (macro-exten-vm, s, 19) exited non-zero on ‘Local/8001@from-queue-0000006d;2’ in macro ‘exten-vm’
== Spawn extension (from-internal, 8001, 3) exited non-zero on ‘Local/8001@from-queue-0000006d;2’
– Executing [h@from-internal:1] Macro (” Local/8001@from-queue-0000006d;2 ", " hangupcall “) in new stack
– Executing [s@macro-hangupcall:1] GotoIf (” Local/8001@from-queue-0000006d;2 ", " 1?theend “) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf (” Local/8001@from-queue-0000006d;2 ", " 0?Set(CDR(recordingfile)=) “) in new stack
– Channel PJSIP/8001-00000032 left ‘simple_bridge’ basic-bridge <5a8f2dac-ecd5-46de-af4c-5069b2dba0ba>
– PJSIP/8001-00000032 Internal Gosub(crm-hangup,s,1) start
– Executing [s@crm-hangup:1] NoOp (” PJSIP/8001-00000032 ", " Sending Hangup to CRM “) in new stack
– Executing [s@crm-hangup:2] NoOp (” PJSIP/8001-00000032 ", " HANGUP CAUSE: 18 “) in new stack
– Executing [s@crm-hangup:3] ExecIf (” PJSIP/8001-00000032 ", " 0?Set(__CRM_VOICEMAIL=) “) in new stack
– Executing [s@crm-hangup:4] NoOp (” PJSIP/8001-00000032 ", " MASTER CHANNEL: 1644776565.270 = 1644776563.267 “) in new stack
– Executing [s@crm-hangup:5] GotoIf (” PJSIP/8001-00000032 ", " 1?return “) in new stack
– Goto (crm-hangup,s,8)
– Executing [s@crm-hangup:8] Return (” PJSIP/8001-00000032 “, “”) in new stack
== Spawn extension (macro-dial-one, s, 1) exited non-zero on ‘PJSIP/8001-00000032’
– PJSIP/8001-00000032 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
– Executing [s@macro-hangupcall:4] NoOp (” Local/8001@from-queue-0000006d;2 ", " PJSIP/8001-00000032 montior file= “) in new stack
– Executing [s@macro-hangupcall:5] GotoIf (” Local/8001@from-queue-0000006d;2 ", " 1?skipagi “) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] Hangup (” Local/8001@from-queue-0000006d;2 “, “”) in new stack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘Local/8001@from-queue-0000006d;2’ in macro ‘hangupcall’
== Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/8001@from-queue-0000006d;2’
– <PJSIP/voip-00000031>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
– Executing [s@crm-hangup:8] Return (” PJSIP/voip-00000031 ", “”) in new stack
== Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/voip-00000031’
– PJSIP/voip-00000031 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

david55 · February 13, 2022, 7:11pm

Your log starts too late. The low level hangup has already happened.

This is typically the result of failing to set the public address or local networks correctly, in the advanced SIP settings, when you are behind NAT. There should be a log message about failing to receive a critical packet. The normal problem is that it is being sent to the private address of the Asterisk machine, rather than the public address of your network router.

freepbxisking · February 13, 2022, 8:24pm

Hi david,

have done that check also and can see translation and media packet loss I have included a full call log but removed DDI and ip’s numbers for security reasons.

Hopefully seeing the full log may shine some light on something being overlooked?

Part 1

Executing [+44NUMBER@from-voip-preprocess:1] Goto (" PJSIP/voip-0000004d ", " from-trunk,+44NUMBER,1 ") in new stack

– Goto (from-trunk,+44NUMBER,1)
– Executing [+44NUMBER@from-trunk:1] Set (" PJSIP/voip-0000004d ", " __DIRECTION=INBOUND “) in new stack
– Executing [+44NUMBER@from-trunk:2] Gosub (” PJSIP/voip-0000004d ", " sub-record-check,s,1(in,+44NUMBER,dontcare) “) in new stack
– Executing [s@sub-record-check:1] GotoIf (” PJSIP/twillo-0000004d ", " 0?initialized “) in new stack
– Executing [s@sub-record-check:2] Set (” PJSIP/voip-0000004d ", " __REC_STATUS=INITIALIZED “) in new stack
– Executing [s@sub-record-check:3] Set (” PJSIP/voip-0000004d ", " NOW=1644780893 “) in new stack
– Executing [s@sub-record-check:4] Set (” PJSIP/voip-0000004d ", " __DAY=13 “) in new stack
– Executing [s@sub-record-check:5] Set (” PJSIP/voip-0000004d ", " __MONTH=02 “) in new stack
– Executing [s@sub-record-check:6] Set (” PJSIP/voip-0000004d ", " __YEAR=2022 “) in new stack
– Executing [s@sub-record-check:7] Set (” PJSIP/voip-0000004d ", " __TIMESTR=20220213-193453 “) in new stack
– Executing [s@sub-record-check:8] Set (” PJSIP/voip-0000004d ", " __FROMEXTEN=unknown “) in new stack
– Executing [s@sub-record-check:9] Set (” PJSIP/voip-0000004d ", " __MON_FMT=wav “) in new stack
– Executing [s@sub-record-check:10] NoOp (” PJSIP/voip-0000004d ", " Recordings initialized “) in new stack
– Executing [s@sub-record-check:11] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(ARG3=dontcare) “) in new stack
– Executing [s@sub-record-check:12] Set (” PJSIP/voip-0000004d ", " REC_POLICY_MODE_SAVE= “) in new stack
– Executing [s@sub-record-check:13] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(REC_STATUS=NO) “) in new stack
– Executing [s@sub-record-check:14] GotoIf (” PJSIP/voip-0000004d ", " 2?checkaction “) in new stack
– Goto (sub-record-check,s,17)
– Executing [s@sub-record-check:17] GotoIf (” PJSIP/voip-0000004d ", " 1?sub-record-check,in,1 “) in new stack
– Goto (sub-record-check,in,1)
– Executing [in@sub-record-check:1] NoOp (” PJSIP/voip-0000004d ", " Inbound Recording Check to +44NUMBER “) n new stack
– Executing [in@sub-record-check:2] Set (” PJSIP/voip-0000004d ", " FROMEXTEN=unknown “) in new stack
– Executing [in@sub-record-check:3] ExecIf (” PJSIP/voip-0000004d ", " 13?Set(FROMEXTEN=+44NUMBER) “) in new stack
– Executing [in@sub-record-check:4] Gosub (” PJSIP/voip-0000004d ", " recordcheck,1(dontcare,in,+44NUMBER) “) in new stack
– Executing [recordcheck@sub-record-check:1] NoOp (” PJSIP/voip-0000004d ", " Starting recording check against dontcare “) in new stack
– Executing [recordcheck@sub-record-check:2] Goto (” PJSIP/voip-0000004d ", " dontcare “) in new stack
– Goto (sub-record-check,recordcheck,3)
– Executing [recordcheck@sub-reord-check:3] Return (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [in@sub-record-check:5] Return (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [+44NUMBER@from-trunk:3] Set (” PJSIP/voip-0000004d ", " CHANNEL(tonezone)=uk “) in new stack
– Executing [+44NUMBER@from-trunk:4] Set (” PJSIP/voip-0000004d ", " __FROM_DID=+44NUMBER “) in new stack
– Executing [+44NUMBER@from-trunk:5] Set (” PJSIP/voip-0000004d ", " returnhere=1 “) in new stack
– Executing [+44NUMBER@from-trunk:6] Gosub (” PJSIP/voip-0000004d ", " app-blacklist-check,s,1() “) in new stack
– Executing [s@app-blacklist-check:1] GotoIf (” PJSIP/voip-0000004d ", " 0?blacklisted “) in new stack
– Executing [s@app-blacklist-check:2] Set (” PJSIP/voip-0000004d ", " CALLED_BLACKLIST=1 “) in new stack
– Executing [s@app-blacklist-check:3] Return (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [+44NUMBER@from-trunk:7] Set (” PJSIP/voip-0000004d ", " CDR(did)=+44NUMBER “) in new stack
– Executing [+44NUMBER@from-trunk:8] GotoIf (” PJSIP/voip-0000004d ", " 0? “) in new stack
– Executing [+44NUMBER@from-trunk:9] ExecIf (” PJSIP/voip-0000004d ", " 0 ?Set(CALLERID(name)=+44NUMBER) “) in new stack
– Executing [+44NUMBER@from-trunk:10] Set (” PJSIP/voip-0000004d ", " CHANNEL(musicclass)=corp “) in new stack
– Executing [+44NUMBER@from-trunk:11] Set (” PJSIP/voip-0000004d ", " __MOHCLASS=corp “) in new stack
– Executing [+44NUMBER@from-trunk:12] Set (” PJSIP/voip-0000004d ", " __REVERSAL_REJECT=FALSE “) in new stack
– Executing [+44NUMBER@from-trunk:13] GotoIf (” PJSIP/voip-0000004d ", " 1?post-reverse-charge “) in new stack
– Goto (from-trunk,+44NUMBER,15)
– Executing [+44NUMBER@from-trunk:15] NoOp (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [+44NUMBER@from-trunk:16] Set (” PJSIP/voip-0000004d ", " __CALLINGNAMEPRES_SV=allowed_not_screened “) in new stack
– Executing [+44NUMBER@from-trunk:17] Set (” PJSIP/voip-0000004d ", " __CALLINGNUMPRES_SV=allowed_not_screened “) in new stack
– Executing [+44NUMBER@from-trunk:18] Set (” PJSIP/voip-0000004d ", " CALLERID(name-pres)=allowed_not_screened “) in new stack
– Executing [+44NUMBER@from-trunk:19] Set (” PJSIP/voip-0000004d ", " CALLERID(num-pres)=allowed_not_screened “) in new stack
– Executing [+44NUMBER@from-trunk:20] NoOp (” PJSIP/voip-0000004d ", " CallerID Entry Point “) in new stack
– Executing [+44NUMBER@from-trunk:21] Set (” PJSIP/voip-0000004d ", " __CRM_DIRECTION=INBOUND “) in new stack
– Executing [+44NUMBER@from-trunk:22] Set (” PJSIP/voip-0000004d ", " __CRM_SOURCE=+447888020899 “) in new stack
– Executing [+44NUMBER@from-trunk:23] Set (” PJSIP/voip-0000004d ", " __CRM_LINKEDID=1644780893.318 “) in new stack
– Executing [+44NUMBER@from-trunk:24] AGI (” PJSIP/voip-0000004d ", " agi://127.0.0.1/sangomacrm.agi,true “) in new stack
– <PJSIP/voip-0000004d>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
– Executing [+44NUMBER@from-trunk:25] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1) “) in new stack
– Executing [+44NUMBER@from-trunk:26] Goto (” PJSIP/voip-0000004d ", " ext-queues,700,1 “) in new stack
– Goto (ext-queues,700,1)
– Executing [700@ext-queues:1] Macro (” PJSIP/voip-0000004d ", " user-callerid, “) in new stack
– Executing [s@macro-user-callerid:1] Set (” PJSIP/voip-0000004d “, " TOUCH_MONITOR=1644780893.318 “) in new stack
– Executing [s@macro-user-callerid:2] Set (” PJSIP/voip-0000004d “, " AMPUSER= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:3] Set (” PJSIP/voip-0000004d ", " HOTDESCKCHAN=voip-0000004d “) in new stack
– Executing [s@macro-user-callerid:4] Set (” PJSIP/voip-0000004d ", " HOTDESKEXTEN=VOIP “) in new stack
– Executing [s@macro-user-callerid:5] Set (” PJSIP/voip-0000004d ", " HOTDESKCALL=0 “) in new stack
– Executing [s@macro-user-callerid:6] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(HOTDESKCALL=1) “) in new stack
– Executing [s@macro-user-callerid:7] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(CALLERID(name)=) “) in new stack
– Executing [s@macro-user-callerid:8] GotoIf (” PJSIP/voip-0000004d ", " 0?report “) in new stack
– Executing [s@macro-user-callerid:9] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(REALCALLERIDNUM= +44NUMBER ) “) in new stack
– Executing [s@macro-user-callerid:10] Set (” PJSIP/voip-0000004d ", " AMPUSER= “) in new stack
– Executing [s@macro-user-callerid:11] GotoIf (” PJSIP/voip-0000004d ", " 0?limit “) in new stack
– Executing [s@macro-user-callerid:12] Set (” PJSIP/voip-0000004d ", " AMPUSERCIDNAME= “) in new stack
– Executing [s@macro-user-callerid:13] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(__CIDMASQUERADING=TRUE) “) in new stack
– Executing [s@macro-user-callerid:14] GotoIf (” PJSIP/voip-0000004d ", " 1?report “) in new stack
– Goto (macro-user-callerid,s,23)
– Executing [s@macro-user-callerid:23] NoOp (” PJSIP/voip-0000004d ", " Macro Depth is 1 “) in new stack
– Executing [s@macro-user-callerid:24] GotoIf (” PJSIP/voip-0000004d ", " 1?report2:macroerror “) in new stack
– Goto (macro-user-callerid,s,25)
– Executing [s@macro-user-callerid:25] GotoIf (” PJSIP/voip-0000004d ", " 0?continue “) in new stack
– Executing [s@macro-user-callerid:26] ExecIf (” PJSIP/voip-0000004d “, " 1?Set(__CALLEE_ACCOUNCODE=) “) in new stack
– Executing [s@macro-user-callerid:27] Set (” PJSIP/voip-0000004d “, " __TTL=64 “) in new stack
– Executing [s@macro-user-callerid:28] GotoIf (” PJSIP/voip-0000004d “, " 1?continue “) in new stack
– Goto (macro-user-callerid,s,44)
– Executing [s@macro-user-callerid:44] Set (” PJSIP/voip-0000004d “, " CALLERID(number)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:45] Set (” PJSIP/voip-0000004d “, " CALLERID(name)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:46] GotoIf (” PJSIP/voip-0000004d “, " 0?cnum “) in new stack
– Executing [s@macro-user-callerid:47] Set (” PJSIP/voip-0000004d “, " CDR(cnam)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:48] Set (” PJSIP/voip-0000004d “, " CDR(cnum)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:49] Set (” PJSIP/voip-0000004d ", " CHANNEL(language)=en_GB “) in new stack
– Executing [700@ext-queues:2] Answer (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [700@ext-queues:3] Macro (” PJSIP/voip-0000004d ", " blkvm-set,reset “) in new stack
– Executing [s@macro-blkvm-set:1] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(__BLKVM_CHANNEL=PJSIP/voip-0000004d) “) in new stack
– Executing [s@macro-blkvm-set:2] Set (” PJSIP/voip-0000004d ", " SHARED(BLKVM,PJSIP/voip-0000004d)=TRUE “) in new stack
– Executing [s@macro-blkvm-set:3] Set (” PJSIP/voip-0000004d ", " GOSUB_RETVAL=TRUE “) in new stack
– Executing [s@macro-blkvm-set:4] MacroExit (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [700@ext-queues:4] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(_DIAL_OPTIONS=HhTtrM(auto-blkvm)) “) in new stack
– Executing [700@ext-queues:5] Set (” PJSIP/voip-0000004d ", " __NODEST=700 “) in new stack
– Executing [700@ext-queues:6] Set (” PJSIP/voip-0000004d ", " __QCONTEXT=0 “) in new stack
– Executing [700@ext-queues:7] Set (” PJSIP/voip-0000004d ", " QCIDPP= “) in new stack
– Executing [700@ext-queues:8] Set (” PJSIP/voip-0000004d ", " VQ_CIDPP= “) in new stack
– Executing [700@ext-queues:9] ExecIf (” PJSIP/voip-0000004d ", " 0?Macro(prepend-cid,) “) in new stack
– Executing [700@ext-queues:10] Set (” PJSIP/voip-0000004d ", " QAINFO= “) in new stack
– Executing [700@ext-queues:11] Set (” PJSIP/voip-0000004d ", " VQ_AINFO= “) in new stack
– Executing [700@ext-queues:12] Set (” PJSIP/voip-0000004d ", " __RVOL_MODE=dontcare “) in new stack
– Executing [700@ext-queues:13] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(__ALERT_INFO=) “) in new stack
– Executing [700@ext-queues:14] Set (” PJSIP/voip-0000004d ", " QJOINMSG=custom/We-apologise-irish “) in new stack
– Executing [700@ext-queues:15] Set (” PJSIP/voip-0000004d ", " VQ_JOINMSG= “) in new stack
– Executing [700@ext-queues:16] Set (” PJSIP/voip-0000004d ", " QCANCELMISSED= “) in new stack
– Executing [700@ext-queues:17] Set (” PJSIP/voip-0000004d ", " QRINGOPTS=R “) in new stack
– Executing [700@ext-queues:18] Set (” PJSIP/voip-0000004d ", " QRETRY= “) in new stack
– Executing [700@ext-queues:19] Set (” PJSIP/voip-0000004d ", " VQ_RETRY= “) in new stack
– Executing [700@ext-queues:20] Set (” PJSIP/voip-0000004d ", " QOPTIONS=tR “) in new stack
– Executing [700@ext-queues:21] Set (” PJSIP/voip-0000004d ", " VQ_OPTIONS= “) in new stack
– Executing [700@ext-queues:22] Set (” PJSIP/voip-0000004d ", " QGOSUB= “) in new stack
– Executing [700@ext-queues:23] Set (” PJSIP/voip-0000004d ", " VQ_GOSUB= “) in new stack
– Executing [700@ext-queues:24] Set (” PJSIP/voip-0000004d ", " QAGI= “) in new stack
– Executing [700@ext-queues:25] Set (” PJSIP/voip-0000004d ", " VQ_AGI= “) in new stack
– Excuting [700@ext-queues:26] Set (” PJSIP/voip-0000004d ", " QRULE= “) in new stack
– Executing [700@ext-queues:27] Set (” PJSIP/voip-0000004d ", " VQ_RULE= “) in new stack
– Executing [700@ext-queues:28] Set (” PJSIP/voip-0000004d ", " QPOSITION= “) in new stack
– Executing [700@ext-queues:29] Set (” PJSIP/voip-0000004d ", " VQ_POSITION= “) in new stack
– Executing [700@ext-queues:30] Gosub (” PJSIP/voip-0000004d ", " sub-record-check,s,1(q,700,dontcare) “) in new stack
– Executing [s@sub-record-check:1] GotoIf (” PJSIP/voip-0000004d ", " 13?initialized “) in new stack
– Goto (sub-record-check,s,10)
– Excuting [s@sub-record-check:10] NoOp (” PJSIP/voip-0000004d ", " Recordings initialized “) in new stack
– Executing [s@sub-record-check:11] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(ARG3=dontcare) “) in new stack
– Executing [s@sub-record-check:12] Set (” PJSIP/voip-0000004d ", " REC_POLICY_MODE_SAVE= “) in new stack
– Executing [s@sub-record-check:13] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(REC_STATUS=NO) “) in new stack
– Executing [s@sub-record-check:14] GotoIf (” PJSIP/voip-0000004d ", " 1?checkaction “) in new stack
– Goto (sub-record-check,s,17)
– Executing [s@sub-record-check:17] GotoIf (” PJSIP/voip-0000004d ", " 0?sub-record-check,q,1 “) in new stack
– Executing [s@sub-record-check:18] NoOp (” PJSIP/voip-0000004d ", " Generic q Recording Check - +44NUMBER 700 “) in new stack
– Executing [s@sub-record-check:19] Gosub (” PJSIP/voip-0000004d ", " recordcheck,1(dontcare,q,700) “) in new stack
– Executing [recordcheck@sub-record-check:1] NoOp (” PJSIP/voip-0000004d ", " Starting recording check against dontcare “) in new stack
– Executing [recordcheck@sub-record-check:2] Goto (” PJSIP/voip-0000004d ", " dontcare “) in new stack
– Goto (sub-record-check,recordcheck,3)
– Executing [recordcheck@sub-record-check:3] Return (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [s@sub-record-check:20] Return (” PJSIP/voip-0000004d “, “”) in new stack
– Executing [700@ext-queues:31] Set (” PJSIP/voip-0000004d ", " __CWIGNORE=TRUE “) in new stack
– Executing [700@ext-queues:32] Set (” PJSIP/voip-0000004d ", " __SIGNORE=TRUE “) in new stack
– Executing [700@ext-queues:33] Set (” PJSIP/voip-0000004d ", " __QC_CONFIRM=0 “) in new stack
– Executing [700@ext-queues:34] GotoIf (” PJSIP/voip-0000004d ", " 0?QVQANNOUNCE:NOQVQANNOUNCE “) in new stack
– Goto (ext-queues,700,39)
– Excuting [700@ext-queues:39] Set (” PJSIP/voip-0000004d ", " VQ_CONFIRMMSG= “) in new stack
– Executing [700@ext-queues:40] ExecIf (” PJSIP/voip-0000004d ", " 0?Playback(custom/We-apologise-irish, ) “) in new stack
– Executing [700@ext-queues:41] QueueLog (” PJSIP/voip-0000004d ", " 700,1644780893.318,NONE,DID,+44NUMBER “) in new stack
– Executing [700@ext-queues:42] Set (” PJSIP/voip-0000004d ", " QAANNOUNCE= “) in new stack
– Executing [700@ext-queues:43] Set (” PJSIP/voip-0000004d ", " VQ_AANNOUNCE= “) in new stack
– Executing [700@ext-queues:44] Set (” PJSIP/voip-0000004d ", " QMOH=corp “) in new stack
– Executing [700@ext-queues:45] Set (” PJSIP/voip-0000004d ", " VQ_MOH= “) in new stack
– Executing [700@ext-queues:46] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(__MOHCLASS=corp) “) in new stack
– Executing [700@ext-queues:47] ExecIf (” PJSIP/voip-0000004d ", " 1?Set(CHANNEL(musicclass)=corp) “) in new stack
– Executing [700@ext-queues:48] Set (” PJSIP/voip-0000004d ", " QMAXWAIT= “) in new stack
– Executing [700@ext-queues:49] Set (” PJSIP/voip-0000004d ", " VQ_MAXWAIT= “) in new stack
– Executing [700@ext-queues:50] Set (” PJSIP/voip-0000004d ", " QUEUENUM=700 “) in new stack
– Executing [700@ext-queues:51] Set (” PJSIP/voip-0000004d ", " QUEUEJOINTIME=1644780894 “) in new stack
– Executing [700@ext-queues:52] Queue (” PJSIP/voip-0000004d ", " 700,tR, ") in

freepbxisking · February 13, 2022, 8:26pm

part 2 of the log

new stack
– Started music on hold, class ‘corp’, on channel ‘PJSIP/voip-0000004d’
– Caled Local/8001@from-queue/n
– – LazyMembers debugging - Numbusies: 0, Nummems: 1
– Executing [8001@from-queue:1] Set (" Local/8001@from-queue-00000077;2 ", " QAGENT=8001 “) in new stack
– Executing [8001@from-queue:2] Set (” Local/8001@from-queue-00000077;2 ", " __FROMQ=true “) in new stack
– Executing [8001@from-queue:3] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?hangup “) in new stack
– Executing [8001@from-queue:4] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?700,1:hangup “) in new stack
– Goto (from-queue,700,1)
– Executing [700@from-queue:1] Goto (” Local/8001@from-queue-00000077;2 ", " from-internal,8001,1 “) in new stack
– Goto (from-internal,8001,1)
– Executing [8001@from-internal:1] Set (” Local/8001@from-queue-00000077;2 ", " __RINGTIMER=15 “) in new stack
– Executing [8001@from-internal:2] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(__CWIGNORE=) “) in new stack
– Executing [8001@from-internal:3] Macro (” Local/8001@from-queue-00000077;2 ", " exten-vm,novm,8001,0,0,0 “) in new stack
– Executing [s@macro-exten-vm:1] Macro (” Local/8001@from-queue-00000077;2 ", " user-callerid, “) in new stack
– Executing [s@macro-user-callerid:1] Set (” Local/8001@from-queue-00000077;2 “, " TOUCH_MONITOR=1644780894.320 “) in new stack
– Executing [s@macro-user-callerid:2] Set (” Local/8001@from-queue-00000077;2 “, " AMPUSER= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:3] Set (” Local/8001@from-queue-00000077;2 ", " HOTDESCKCHAN=8001@from-queue-00000077;2 “) in new stack
– Executing [s@macro-user-callerid:4] Set (” Local/8001@from-queue-00000077;2 ", " HOTDESKEXTEN=8001@from “) in new stack
– Executing [s@macro-user-callerid:5] Set (” Local/8001@from-queue-00000077;2 ", " HOTDESKCALL=0 “) in new stack
– Executing [s@macro-user-callerid:6] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(DOTDESKCALL=1) “) in new stack
– Executing [s@macro-user-callerid:7] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(CALLERID(name)=) “) in new stack
– Executing [s@macro-user-callerid:8] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?report “) in new stack
– Goto (macro-user-callerid,s,23)
– Executing [s@macro-user-callerid:23] NoOp (” Local/8001@from-queue-00000077;2 ", " Macro Depth is 2 “) in new stack
– Executing [s@macro-user-callerid:24] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?report2:macroerror “) in new stack
– Goto (macro-user-callerid,s,25)
– Executing [s@macro-user-callerid:25] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?continue “) in new stack
– Executing [s@macro-user-callerid:26] ExecIf (” Local/8001@from-queue-00000077;2 “, " 1?Set(__CALLEE_ACCOUNCODE=) “) in new stack
– Executing [s@macro-user-callerid:27] Set (” Local/8001@from-queue-00000077;2 “, " __TTL=63 “) in new stack
– Executing [s@macro-user-callerid:28] GotoIf (” Local/8001@from-queue-00000077;2 “, " 1?continue “) in new stack
– Goto (macro-user-callerid,s,44)
– Executing [s@macro-user-callerid:44] Set (” Local/8001@from-queue-00000077;2 “, " CALLERID(number)=+ +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:45] Set (” Local/8001@from-queue-00000077;2 “, " CALLERID(name)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:46] GotoIf (” Local/8001@from-queue-00000077;2 “, " 0?cnum “) in new stack
– Executing [s@macro-user-callerid:47] Set (” Local/8001@from-queue-00000077;2 “, " CDR(cnam)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:48] Set (” Local/8001@from-queue-00000077;2 “, " CDR(cnum)= +44NUMBER”) in new stack
– Executing [s@macro-user-callerid:49] Set (” Local/8001@from-queue-00000077;2 ", " CHANNEL(language)=en_GB “) in new stack
– Executing [s@macro-exten-vm:2] Set (” Local/8001@from-queue-00000077;2 ", " RingGroupMethod=none “) in new stack
– Executing [s@macro-exten-vm:3] Set (” Local/8001@from-queue-00000077;2 ", " __EXTTOCALL=8001 “) in new stack
– Executing [s@macro-exten-vm:4] Set (” Local/8001@from-queue-00000077;2 ", " __PICKUPMARK=8001 “) in new stack
– Executing [s@macro-exten-vm:5] Set (” Local/8001@from-queue-00000077;2 ", " RT= “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:6] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Macro(vm,novm,DIRECTDIAL,) “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:7] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:8] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Gosub(ext-intercom,nointercom8001,1()) “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:9] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:10] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?ChanSpy(PJSIP/8001,q) “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:11] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] WARNING [28833][C-0000002e]: chan_sip.c : 23254 func_header_read : This function can only be used on SIP channels.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:12] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Macro(vm,novm,DIRECTDIAL,) “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:13] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:14] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Gosub(ext-intercom,nointercom8001,1()) “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_red_header : This function requires a PJSIP channel.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:15] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:16] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?ChanSpy(PJSIP/8001,q) “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:17] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?MacroExit() “) in new stack
[2022-02-13 19:34:54] ERROR [28833][C-0000002e]: res_pjsip_header_funcs.c : 454 func_read_header : This function requires a PJSIP channel.
– Executing [s@macro-exten-vm:18] Gosub (” Local/8001@from-queue-00000077;2 ", " sub-record-check,s,1(exten,8001,dontcare) “) in new stack
– Executing [s@sub-record-check:1] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?initialized “) in new stack
– Executing [s@sub-record-check:2] Set (” Local/8001@from-queue-00000077;2 ", " __REC_STATUS=INITIALIZED “) in new stack
– Executing [s@sub-record-check:3] Set (” Local/8001@from-queue-00000077;2 ", " NOW=1644780894 “) in new stack
– Executing [s@sub-record-check:4] Set (” Local/8001@from-queue-00000077;2 ", " __DAY=13 “) in new stack
– Executing [s@sub-record-check:5] Set (” Local/8001@from-queue-00000077;2 ", " __MONTH=02 “) in new stack
– Executing [s@sub-record-check:6] Set (” Local/8001@from-queue-00000077;2 ", " __YEAR=2022 “) in new stack
– Executing [s@sub-record-check:7] Set (” Local/8001@from-queue-00000077;2 ", " __TIMESTR=20220213-193454 “) in new stack
– Executing [s@sub-record-check:8] Set (” Local/8001@from-queue-00000077;2 ", " __FROMEXTEN=+447888020899 “) in new stack
– Executing [s@sub-record-check:9] Set (” Local/8001@from-queue-00000077;2 ", " __MON_FMT=wav “) in new stack
– Executing [s@sub-record-check:10] NoOp (” Local/8001@from-queue-00000077;2 ", " Recordings initialized “) in new stack
– Executing [s@sub-record-check:11] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(ARG3=dontcare) “) in new stack
– Executing [s@sub-record-check:12] Set (” Local/8001@from-queue-00000077;2 ", " REC_POLICY_MODE_SAVE= “) in new stack
– Executing [s@sub-record-check:13] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(REC_STATUS=NO) “) in new stack
– Executing [s@sub-record-check:14] GotoIf (” Local/8001@from-queue-00000077;2 ", " 5?checkaction “) in new stack
– Goto (sub-record-check,s,17)
– Executing [s@sub-record-check:17] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?sub-record-check,exten,1 “) in new stack
– Goto (sub-record-check,exten,1)
– Executing [exten@sub-record-check:1] NoOp (” Local/8001@from-queue-00000077;2 ", " Exten Recording Check between +447888020899 and 8001 “) in new stack
– Executing [exten@sub-record-check:2] Set (” Local/8001@from-queue-00000077;2 ", " CALLTYPE=external “) in new stack
– Executing [exten@sub-record-check:3] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(CALLTYPE=) “) in new stack
– Executing [exten@sub-record-check:4] Set (” Local/8001@from-queue-00000077;2 ", " CALLEE=dontcare “) in new stack
– Executing [exten@sub-record-check:5] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(CALLEE=dontcare) “) in new stack
– Excuting [exten@sub-record-check:6] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?callee ") in new stack

freepbxisking · February 13, 2022, 8:26pm

part 3

– Goto (sub-record-check,exten,11)
– Executing [exten@sub-record-check:11] Gosub (" Local/8001@from-queue-00000077;2 ", " recordcheck,1(dontcare,external,8001) “) in new stack
– Executing [recordcheck@sub-record-check:1] NoOp (” Local/8001@from-queue-00000077;2 ", " Starting recording check against dontcare “) in new stack
– Executing [recordcheck@sub-record-check:2] Goto (” Local/8001@from-queue-00000077;2 ", " dontcare “) in new stack
– Goto (sub-record-check,recordcheck,3)
– Excuting [recordcheck@sub-record-check:3] Return (” Local/8001@from-queue-00000077;2 “, “”) in new stack
– Excuting [exten@sub-record-check:12] Return (” Local/8001@from-queue-00000077;2 “, “”) in newstack
– Executing [s@macro-exten-vm:19] Macro (” Local/8001@from-queue-00000077;2 ", " dial-one,HhTtrM(auto-blkvm),8001 “) in new stack
– Executing [s@macro-dial-one:1] Set (” Local/8001@from-queue-00000077;2 “, " DEXTEN=8001 “) in new stack
– Executing [s@macro-dial-one:2] Set (” Local/8001@from-queue-00000077;2 “, " __CRM_SOURCE= +44NUMBER”) in new stack
– Executing [s@macro-dial-one:3] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(__EXTTOCALL=8001) “) in new stack
– Executing [s@macro-dial-one:4] Set (” Local/8001@from-queue-00000077;2 ", " DIALSTATUS_CW= “) in new stack
– Executing [s@macro-dial-one:5] GosubIf (” Local/8001@from-queue-00000077;2 ", " 0?screen,1() “) in new stack
– Executing [s@macro-dial-one:6] GosubIf (” Local/8001@from-queue-00000077;2 ", " 0?cf,1() “) in new stack
– Executing [s@macro-dial-one:7] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?skip1 “) in new stack
– Goto (macro-dial-one,s,10)
– Excuting [s@macro-dial-one:10] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?nodial “) in new stack
– Executing [s@macro-dial-one:11] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?continue “) in new stack
– Executing [s@macro-dial-one:12] Set (” Local/8001@from-queue-00000077;2 ", " EXTHASCW= “) in new stack
– Executing [s@macro-dial-one:13] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?next1:cwinusebusy “) in new stack
– Goto (macro-dial-one,s,14)
– Executing [s@macro-dial-one:14] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?docfu:skip3 “) in new stack
– Goto (macro-dial-one,s,18)
– Executing [s@macro-dial-one:18] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?next2:continue “) in new stack
– Goto (macro-dial-one,s,19)
– Executing [s@macro-dial-one:19] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?continue “) in new stack
– Goto (macro-dial-one,s,27)
– Executing [s@macro-dial-one:27] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?nodial “) in new stack
– Executing [s@macro-dial-one:28] GosubIf (” Local/8001@from-queue-00000077;2 ", " 1?dstring,1():dlocal,1() “) in new stack
– Executing [dstring@macro-dial-one:1] Set (” Local/8001@from-queue-00000077;2 ", " DSTRING= “) in new stack
– Executing [dstring@macro-dial-one:2] Set (” Local/8001@from-queue-00000077;2 ", " DEVICES=8001 “) in new stack
– Executing [dstring@macro-dial-one:3] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Return() “) in new stack
– Executing [dstring@macro-dial-one:4] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(DEVICES=001) “) in new stack
– Executing [dstring@macro-dial-one:5] Set (” Local/8001@from-queue-00000077;2 ", " LOOPCNT=1 “) in new stack
– Executing [dstring@macro-dial-one:6] Set (” Local/8001@from-queue-00000077;2 ", " ITER=1 “) in new stack
– Executing [dstring@macro-dial-one:7] Set (” Local/8001@from-queue-00000077;2 ", " THISDIAL=PJSIP/8001 “) in new stack
– Executing [dstring@macro-dial-one:8] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?docheck “) in new stack
– Executing [dstring@macro-dial-one:9] NoOp (” Local/8001@from-queue-00000077;2 ", " Debug: Found PJSIP Destination PJSIP/8001 “) in new stack
– Executing [dstring@macro-dial-one:10] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?doset “) in new stack
– Executing [dstring@macro-dial-one:11] NoOp (” Local/8001@from-queue-00000077;2 ", " Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS “) in new stack
– Executing [dstring@macro-dial-one:12] Set (” Local/8001@from-queue-00000077;2 ", " THISDIAL=PJSIP/8001/sip:8001@IP:12049;transport=TCP “) in new stack
– Executing [dstring@macro-dial-one:13] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(DIALSTATUS=CHANUNAVAIL) “) in new stack
– Executing [dstring@macro-dial-one:14] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?skipset “) in new stack
– Executing [dstring@macro-dial-one:15] Set (” Local/8001@from-queue-00000077;2 ", " DSTRING=PJSIP/8001/sip:8001@IP:12049;transport=TCP& “) in new stack
– Executing [dstring@macro-dial-one:16] Set (” Local/8001@from-queue-00000077;2 ", " ITER=2 “) in new stack
– Executing [dstring@macro-dial-one:17] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?begin “) in new stack
– Executing [dstring@macro-dial-one:18] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Return() “) in new stack
– Executing [dstring@macro-dial-one:19] Set (” Local/8001@from-queue-00000077;2 ", " DSTRING=PJSIP/8001/sip:8001@IP:12049;transport=TCP “) in new stack
– Executing [dstring@macro-dial-one:20] Return (” Local/8001@from-queue-00000077;2 “, “”) in new stack
– Executing [s@macro-dial-one:29] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?nodial “) in new stack
– Executing [s@macro-dial-one:30] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?skiptrace “) in new stack
– Executing [s@macro-dial-one:31] GosubIf (” Local/8001@from-queue-00000077;2 “, " 1?ctset,1():ctclear,1() “) in new stack
– Executing [ctset@macro-dial-one:1] Set (” Local/8001@from-queue-00000077;2 “, " DB(CALLTRACE/8001)= +44NUMBER”) in new stack
– Executing [ctset@macro-dial-one:2] Return (” Local/8001@from-queue-00000077;2 “, “”) in new stack
– Executing [s@macro-dial-one:32] Set (” Local/8001@from-queue-00000077;2 ", " D_OPTIONS=HhTtrM(auto-blkvm) “) in new stack
– Executing [s@macro-dial-one:33] GosubIf (” Local/8001@from-queue-00000077;2 ", " 0?func-set-sipheader,s,1(Alert-Info,) “) in new stack
– Executing [s@macro-dial-one:34] NoOp (” Local/8001@from-queue-00000077;2 ", " Blind Transfer: , Attended Transfer: , User: +44NUMBER , Alert Info: “) in new stack
– Executing [s@macro-dial-one:35] ExecIf (” Local/8001@from-queue-00000077;2 ", " 1?Set(ALERT_INFO=) “) in new stack
– Executing [s@macro-dial-one:36] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(ALERT_INFO=) “) in new stack
– Executing [s@macro-dial-one:37] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(ALERT_INFO=) “) in new stack
– Executing [s@macro-dial-one:38] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(ALERT_INFO=Normal;volume=) “) in new stack
– Executing [s@macro-dial-one:39] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(ALERT_INFO=Normal;volume=) “) in new stack
– Executing [s@macro-dial-one:40] GosubIf (” Local/8001@from-queue-00000077;2 ", " 0?func-set-sipheader,s,1(Alert-Info,) “) in new stack
– Executing [s@macro-dial-one:41] ExecIf (” Local/8001@from-queue-00000077;2 ", " 1?Set(CHANNEL(musicclass)=corp) “) in new stack
– Executing [s@macro-dial-one:42] GosubIf (” Local/8001@from-queue-00000077;2 ", " 0?qwait,1() “) in new stack
– Executing [s@macro-dial-one:43] Set (” Local/8001@from-queue-00000077;2 ", " __CWIGNORE=TRUE “) in new stack
– Executing [s@macro-dial-one:44] Set (” Local/8001@from-queue-00000077;2 ", " __KEEPCID=TRUE “) in new stack
– Executing [s@macro-dial-one:45] GotoIf (” Local/8001@from-queue-00000077;2 ", " 0?usegoto,1 “) in new stack
– Executing [s@macro-dial-one:46] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?godial “) in new stack
– Goto (macro-dial-one,s,51)
– Executing [s@macro-dial-one:51] Macro (” Local/8001@from-queue-00000077;2 ", " dialout-one-predial-hook, “) in new stack
– Executing [s@macro-dialout-one-predial-hook:1] MacroExit (” Local/8001@from-queue-00000077;2 “, “”) in new stack
– Executing [s@macro-dial-one:52] ExecIf (” Local/8001@from-queue-00000077;2 ", " 1?Set(D_OPTIONS=HhtrM(auto-blkvm)I) “) in new stack
– Executing [s@macro-dial-one:53] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(CWRING=r(callwaiting)):Set(CWRING=) “) in new stack
– Executing [s@macro-dial-one:54] NoOp (” Local/8001@from-queue-00000077;2 “, “”) in new stack
– Executing [s@macro-dial-one:55] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(D_OPTIONS=HhtrM(auto-blkvm)Ig) “) in new stack
– Executing [s@macro-dial-one:56] Dial (” Local/8001@from-queue-00000077;2 ", " PJSIP/8001/sip:[email protected]:12049;transport=TCP,HhtrM(auto-blkvm)Ib(func-apply-sipheaders^s^1) “) in new stack
– PJSIP/8001-0000004e Internal Gosub(func-apply-sipheaders,s,1) start
– Executing [s@func-apply-sipheaders:1] ExecIf (” PJSIP/8001-0000004e ", " 1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1) “) in new stack
– Executing [s@func-apply-sipheaders:2] NoOp (” PJSIP/8001-0000004e ", " Applying SIP Headers to channel PJSIP/8001-0000004e “) in new stack
– Executing [s@func-apply-sipheaders:3] Set (” PJSIP/8001-0000004e ", " TECH=PJSIP “) in new stack
– Executing [s@func-apply-sipheaders:4] Set (” PJSIP/8001-0000004e ", " SIPHEADERKEYS= “) in new stack
– Executing [s@func-apply-sipheaders:5] While (” PJSIP/8001-0000004e ", " 0 “) in new stack
– Jumping to priority 13
– Executing [s@func-apply-sipheaders:14] Return (” PJSIP/8001-0000004e “, “”) in new stack
== Spawn extension (from-internal, 8001, 1) exited non-zero on ‘PJSIP/8001-0000004e’
– PJSIP/8001-0000004e Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
– Called PJSIP/8001/sip:8001@IP:12049;transport=TCP
– Local/8001@from-queue-00000077;1 is ringing
– Stopped music on hold on PJSIP/voip-0000004d
== Using SIP RTP Audio TOS bits 184
== Using SIP RTP Audio TOS bits 184 in TCLASS field.
== Using SIP RTP Audio CoS mark 5
– Connected line update to Local/8001@from-queue-00000077;2 prevented.
– PJSIP/8001-0000004e is ringing
– Local/8001@from-queue-00000077;1 is ringing
– PJSIP/8001-0000004e answered Local/8001@from-queue-00000077;2
– Executing [s@macro-auto-blkvm:1] ExecIf (” PJSIP/8001-0000004e ", " 0?Set(CDR(recordingfile)=.wav) “) in new stack
– Executing [s@macro-auto-blkvm:2] Set (” PJSIP/8001-0000004e ", " __MACRO_RESULT= “) in new stack
– Executing [s@macro-auto-blkvm:3] Set (” PJSIP/8001-0000004e ", " CFIGNORE= “) in new stack
– Executing [s@macro-auto-blkvm:4] Set (” PJSIP/8001-0000004e ", " MASTER_CHANNEL(CFIGNORE)= “) in new stack
– Executing [s@macro-auto-blkvm:5] Set (” PJSIP/8001-0000004e ", " FORWARD_CONTEXT=from-internal “) in new stack
– Executing [s@macro-auto-blkvm:6] Set (” PJSIP/8001-0000004e ", " MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal “) in new stack
– Executing [s@macro-auto-blkvm:7] Macro (” PJSIP/8001-0000004e ", " blkvm-clr, “) in new stack
– Executing [s@macro-blkvm-clr:1] Set (” PJSIP/8001-0000004e ", " SHARED(BLKVM,PJSIP/voip-0000004d)= “) in new stack
– Executing [s@macro-blkvm-clr:2] Set (” PJSIP/8001-0000004e ", " GOSUB_RETVAL= “) in new stack
– Executing [s@macro-blkvm-clr:3] MacroExit (” PJSIP/8001-0000004e “, “”) in new stack
– Executing [s@macro-auto-blkvm:8] ExecIf (” PJSIP/8001-0000004e ", " 0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=8001/sip:8001@IP:12049;transport=TCP) “) in new stack
– Executing [s@macro-auto-blkvm:9] ExecIf (” PJSIP/8001-0000004e ", " 0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=) “) in new stack
[2022-02-13 19:35:00] WARNING [28847][C-0000002e]: features_config.c : 1366 ast_get_chan_applicationmap : Unknown DYNAMIC_FEATURES item ‘apprecord’ on channel PJSIP/8001-0000004e.
– Channel PJSIP/8001-0000004e joined ‘simple_bridge’ basic-bridge
[2022-02-13 19:35:00] WARNING [28833][C-0000002e]: features_config.c : 1366 ast_get_chan_applicationmap : Unknown DYNAMIC_FEATURES item ‘apprecord’ on channel Local/8001@from-queue-00000077;2.
– Channel Local/8001@from-queue-00000077;2 joined ‘simple_bridge’ basic-bridge
– Local/8001@from-queue-00000077;1 answered PJSIP/voip-0000004d
– <Local/8001@from-queue-00000077;1> Playing ‘queue-reporthold.ulaw’ (language ‘en_GB’)
– <Local/8001@from-queue-00000077;1> Playing ‘digits/7.ulaw’ (language ‘en_GB’)
– <Local/8001@from-queue-00000077;1> Playing ‘queue-seconds.ulaw’ (language ‘en_GB’)
[2022-02-13 19:35:03] WARNING [28821][C-0000002e]: features_config.c : 1366 ast_get_chan_applicationmap : Unknown DYNAMIC_FEATURES item ‘apprecord’ on channel PJSIP/voip-0000004d.
[2022-02-13 19:35:03] WARNING [28854][C-0000002e]: features_config.c : 1366 ast_get_chan_applicationmap : Unknown DYNAMIC_FEATURES item ‘apprecord’ on channel Local/8001@from-queue-00000077;1.
– Channel Local/8001@from-queue-00000077;1 joined ‘simple_bridge’ basic-bridge <145ab218-9765-4309-af9e-71bdebac82e9>
[2022-02-13 19:35:03] WARNING [28821][C-0000002e]: features_config.c : 1366 ast_get_chan_applicationmap : Unknown DYNAMIC_FEATURES item ‘apprecord’ on channel PJSIP/voip-0000004d.
– Channel PJSIP/voip-0000004d joined ‘simple_bridge’ basic-bridge <145ab218-9765-4309-af9e-71bdebac82e9>
– Channel PJSIP/voip-0000004d left ‘simple_bridge’ basic-bridge <145ab218-9765-4309-af9e-71bdebac82e9>
== Spawn extension (ext-queues, 700, 52) exited non-zero on ‘PJSIP/voip-0000004d’
– Executing [h@ext-queues:1] Macro (” PJSIP/voip-0000004d ", " hangupcall, “) in new stack
– Executing [s@macro-hangupcall:1] GotoIf (” PJSIP/voip-0000004d ", " 1?theend “) in new stack
– Goto (macro-hangupcall,s,3)
– Channel Local/8001@from-queue-00000077;1 left ‘simple_bridge’ basic-bridge <145ab218-9765-4309-af9e-71bdebac82e9>
– Channel Local/8001@from-queue-00000077;2 left ‘simple_bridge’ basic-bridge
== Spawn extension (macro-dial-one, s, 56) exited non-zero on ‘Local/8001@from-queue-00000077;2’ in macro ‘dial-one’
== Spawn extension (macro-exten-vm, s, 19) exited non-zero on ‘Local/8001@from-queue-00000077;2’ in macro ‘exten-vm’
== Spawn extension (from-internal, 8001, 3) exited non-zero on ‘Local/8001@from-queue-00000077;2’
– Executing [h@from-internal:1] Macro (” Local/8001@from-queue-00000077;2 ", " hangupcall “) in new stack
– Executing [s@macro-hangupcall:1] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?theend “) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(CDR(recordingfile)=) “) in new stack
– Executing [s@macro-hangupcall:4] NoOp (” PJSIP/voip-0000004d ", " Local/8001@from-queue-00000077;1 montior file= “) in new stack
– Executing [s@macro-hangupcall:5] GotoIf (” PJSIP/voip-0000004d ", " 1?skipagi “) in new stack
– Channel PJSIP/8001-0000004e left ‘simple_bridge’ basic-bridge
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] Hangup (” PJSIP/voip-0000004d “, “”) in new stack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/voip-0000004d’ in macro ‘hangupcall’
– PJSIP/8001-0000004e Internal Gosub(crm-hangup,s,1) start
– Executing [s@crm-hangup:1] NoOp (” PJSIP/8001-0000004e ", " Sending Hangup to CRM “) in new stack
== Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/voip-0000004d’
– PJSIP/voip-0000004d Internal Gosub(crm-hangup,s,1) start
– Executing [s@crm-hangup:2] NoOp (” PJSIP/8001-0000004e ", " HANGUP CAUSE: 18 “) in new stack
– Executing [s@crm-hangup:1] NoOp (” PJSIP/voip-0000004d ", " Sending Hangup to CRM “) in new stack
– Executing [s@crm-hangup:2] NoOp (” PJSIP/voip-0000004d ", " HANGUP CAUSE: 18 “) in new stack
– Executing [s@crm-hangup:3] ExecIf (” PJSIP/8001-0000004e ", " 0?Set(__CRM_VOICEMAIL=) “) in new stack
– Executing [s@crm-hangup:3] ExecIf (” PJSIP/voip-0000004d ", " 0?Set(__CRM_VOICEMAIL=) “) in new stack
– Executing [s@crm-hangup:4] NoOp (” PJSIP/voip-0000004d ", " MASTER CHANNEL: 1644780893.318 = 1644780893.318 “) in new stack
– Executing [s@crm-hangup:4] NoOp (” PJSIP/8001-0000004e ", " MASTER CHANNEL: 1644780894.321 = 1644780893.318 “) in new stack
– Executing [s@crm-hangup:5] GotoIf (” PJSIP/voip-0000004d ", " 0?return “) in new stack
– Executing [s@crm-hangup:6] Set (” PJSIP/voip-0000004d ", " __CRM_HANGUP=1 “) in new stack
– Executing [s@crm-hangup:7] AGI (” PJSIP/voip-0000004d ", " agi://127.0.0.1/sangomacrm.agi “) in new stack
– Executing [s@macro-hangupcall:3] ExecIf (” Local/8001@from-queue-00000077;2 ", " 0?Set(CDR(recordingfile)=) “) in new stack
– Executing [s@macro-hangupcall:4] NoOp (” Local/8001@from-queue-00000077;2 ", " PJSIP/8001-0000004e montior file= “) in new stack
– Executing [s@macro-hangupcall:5] GotoIf (” Local/8001@from-queue-00000077;2 ", " 1?skipagi “) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] Hangup (” Local/8001@from-queue-00000077;2 “, “”) in new stack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘Local/8001@frm-queue-00000077;2’ in macro ‘hangupcall’
== Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/8001@from-queue-00000077;2’
– Executing [s@crm-hangup:5] GotoIf (” PJSIP/8001-0000004e ", " 1?return “) in new stack
– Goto (crm-hangup,s,8)
– Executing [s@crm-hangup:8] Return (” PJSIP/8001-0000004e “, “”) in new stack
== Spawn extension (macro-dial-one, s, 1) exited non-zero on ‘PJSIP/8001-0000004e’
– PJSIP/8001-0000004e Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
– <PJSIP/voip-0000004d>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
– Executing [s@crm-hangup:8] Return (” PJSIP/voip-0000004d ", “”) in new stack
== Spawn extension (ext-queues, h, 1) exited non-zero on ‘PJSIP/voip-0000004d’
– PJSIP/voip-0000004d Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

david55 · February 13, 2022, 9:48pm

You need to take logs from the full log file, not the screen. The screen version doesn’t have a complete set of timestamps. You should also upload them to pastebin.freepbx.org.

The failure is on the incoming side. There is no reason given, and I’m not sure if chan_pjsip logs a message for reaching the limit on sending unacknowledged final responses. One may need to enable “psjsip set logger on”, using the CLI, to see which side cleared, and certainly to see whether the correct contact address is being sent.

system · March 16, 2022, 9:48pm

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