So in the 434 breakout menu (ivr-3) they pressed 2, which takes them to ivr-1 the main IVR
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:1] Macro("PJSIP/246-000001c0", "blkvm-clr,") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:1] Set("PJSIP/246-000001c0", "SHARED(BLKVM,PJSIP/246-000001c0)=") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:2] Set("PJSIP/246-000001c0", "GOSUB_RETVAL=") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:3] MacroExit("PJSIP/246-000001c0", "") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:2] Set("PJSIP/246-000001c0", "__NODEST=") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:3] Set("PJSIP/246-000001c0", "__ivrreturn=0") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:4] Goto("PJSIP/246-000001c0", "ivr-1,s,1") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx_builtins.c: Goto (ivr-1,s,1)
They pressed 1 to go to queue 401
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:10] ExecIf("PJSIP/246-000001c0", "1?Background(custom/mainmenu_placeholder)") in new stack
[2020-11-24 12:54:35] VERBOSE[16177][C-0000006e] file.c: <PJSIP/246-000001c0> Playing 'custom/mainmenu_placeholder.slin' (language 'en')
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:1] Set("PJSIP/246-000001c0", "__ivrreturn=0") in new stack .
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:2] Goto("PJSIP/246-000001c0", "ext-queues,401,1") in new stack .
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx_builtins.c: Goto (ext-queues,401,1)
And it sure seems to be going to 401
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:48] Set("PJSIP/246-000001c0", "QUEUENUM=401") in new stack
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:49] Set("PJSIP/246-000001c0", "QUEUEJOINTIME=1606251279") in new stack
[2020-11-24 12:54:39] VERBOSE[16177][C-0000006e] pbx.c: Executing [[email protected]:50] Queue("PJSIP/246-000001c0", "401,t,,,,,,,,") in new stack
So it appears to be working just fine! What makes you say that they went back to 434?
Then with the second part in the logs, which seems unrelated to the issue you have. It’s on a different day as well. It doesn’t appear like the caller pressed anything on the breakout menu, nor was it presented to them.
Call to 7777 comes in, goes to the IVR
they press 1:
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx.c: Executing [[email protected]:1] Set("PJSIP/243-00000086", "__ivrreturn=0") in new stack
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx.c: Executing [[email protected]:2] Goto("PJSIP/243-00000086", "ext-queues,401,1") in new stack
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx_builtins.c: Goto (ext-queues,401,1
And it went to the queue (401) just fine
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx.c: Executing [[email protected]:48] Set("PJSIP/243-00000086", "QUEUENUM=401") in new stack
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx.c: Executing [[email protected]:49] Set("PJSIP/243-00000086", "QUEUEJOINTIME=1605648111") in new stack
./full-20201118:[2020-11-17 13:21:51] VERBOSE[21804][C-0000006e] pbx.c: Executing [[email protected]:50] Queue("PJSIP/243-00000086", "401,t,,,,,,,,") in new stack
246 answered:
/full-20201118:[2020-11-17 13:32:13] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008c answered Local/[email protected];2
./full-20201118:[2020-11-17 13:32:13] VERBOSE[23440][C-0000006e] bridge_channel.c: Channel PJSIP/246-0000008c joined 'simple_bridge' basic-bridge <f62c783f-2585-41f6-b239-0869b63c51ec>
./full-20201118:[2020-11-17 13:32:13] VERBOSE[21827][C-0000006e] bridge_channel.c: Channel Local/[email protected];2 joined 'simple_bridge' basic-bridge <f62c783f-2585-41f6-b239-0869b63c51ec>
Then performed a blind transfer:
./full-20201118:[2020-11-17 13:37:44] VERBOSE[23440][C-0000006e] bridge_basic.c: Channel PJSIP/246-0000008c: Started DTMF blind transfer.
Which parked the call
./full-20201118:[2020-11-17 13:37:44] VERBOSE[23440][C-0000006e] file.c: <PJSIP/246-0000008c> Playing 'digits/7.ulaw' (language 'en')
./full-20201118:[2020-11-17 13:37:45] VERBOSE[23440][C-0000006e] file.c: <PJSIP/246-0000008c> Playing 'digits/1.ulaw' (language 'en')
Park timed out and the call went back to 246, they answered.
./full-20201118:[2020-11-17 13:47:44] VERBOSE[21827][C-0000006e] app_dial.c: Called PJSIP/246/sip:[email protected]:5060
./full-20201118:[2020-11-17 13:47:44] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008d is ringing
./full-20201118:[2020-11-17 13:47:44] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008d is ringing
./full-20201118:[2020-11-17 13:47:51] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008d answered Local/[email protected];2
Parked again:
./full-20201118:[2020-11-17 13:47:54] VERBOSE[25862][C-0000006e] file.c: <PJSIP/246-0000008d> Playing 'digits/7.ulaw' (language 'en') ./full-20201118:[2020-11-17 13:47:54] VERBOSE[25862][C-0000006e] file.c: <PJSIP/246-0000008d> Playing 'digits/1.ulaw' (language 'en')
Timed out again, went to 246, they answered:
./full-20201118:[2020-11-17 13:57:54] VERBOSE[21827][C-0000006e] app_dial.c: Called PJSIP/246/sip:[email protected]:5060
./full-20201118:[2020-11-17 13:57:54] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008e is ringing
./full-20201118:[2020-11-17 13:57:54] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008e is ringing
./full-20201118:[2020-11-17 13:57:57] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008e answered Local/[email protected];2
Parked a third time:
./full-20201118:[2020-11-17 13:58:02] VERBOSE[27436][C-0000006e] file.c: <PJSIP/246-0000008e> Playing 'digits/7.ulaw' (language 'en')
./full-20201118:[2020-11-17 13:58:03] VERBOSE[27436][C-0000006e] file.c: <PJSIP/246-0000008e> Playing 'digits/1.ulaw' (language 'en')
Timed out third time, went to 246 they asnwered.
./full-20201118:[2020-11-17 14:08:02] VERBOSE[21827][C-0000006e] app_dial.c: Called PJSIP/246/sip:[email protected]:5060
./full-20201118:[2020-11-17 14:08:02] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008f is ringing
./full-20201118:[2020-11-17 14:08:02] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008f is ringing
./full-20201118:[2020-11-17 14:08:04] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-0000008f answered Local/[email protected];2
parked a 4th time:
./full-20201118:[2020-11-17 14:08:07] VERBOSE[29022][C-0000006e] file.c: <PJSIP/246-0000008f> Playing 'digits/7.ulaw' (language 'en')
./full-20201118:[2020-11-17 14:08:08] VERBOSE[29022][C-0000006e] file.c: <PJSIP/246-0000008f> Playing 'digits/1.ulaw' (language 'en')
Timed out 4th time, went to 246, they answered.
./full-20201118:[2020-11-17 14:18:07] VERBOSE[21827][C-0000006e] app_dial.c: Called PJSIP/246/sip:[email protected]:5060
./full-20201118:[2020-11-17 14:18:08] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-00000093 is ringing
./full-20201118:[2020-11-17 14:18:08] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-00000093 is ringing
./full-20201118:[2020-11-17 14:18:09] VERBOSE[21827][C-0000006e] app_dial.c: PJSIP/246-00000093 answered Local/[email protected];2
Finally, this time 246 terminated the call
./full-20201118:[2020-11-17 14:18:13] VERBOSE[30524][C-0000006e] bridge_channel.c: Channel PJSIP/246-00000093 left 'simple_bridge' basic-bridge <40236ee7-a484-465c-aca6-e63abf5b9cc4>
./full-20201118:[2020-11-17 14:18:13] VERBOSE[21827][C-0000006e] bridge_channel.c: Channel Local/[email protected];2 left 'simple_bridge' basic-bridge <40236ee7-a484-465c-aca6-e63abf5b9cc4>