[2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [c5u25q4@company_5-queue-to-agent:1] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "Internal call") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [c5u25q4@company_5-queue-to-agent:2] ExecIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?Dumpchan()") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [c5u25q4@company_5-queue-to-agent:3] AGI("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "agi://127.0.0.1/ngpbx_from-queue") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] res_agi.c: AGI Script agi://127.0.0.1/ngpbx_from-queue completed, returning 0 [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [c5u25q4@company_5-queue-to-agent:4] GotoIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "16?app-queue-to-agent-real,dddddddddd,1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [dddddddddd@app-queue-to-agent-real:1] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [dddddddddd@app-queue-to-agent-real:2] Set("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "_PRE_DIAL_HANDLER=handler^agent_call^1,") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [dddddddddd@app-queue-to-agent-real:3] Gosub("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "do-dial-options,s,1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:1] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "t") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:2] ExecIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?Set(__PRE_BRIDGE_HANDLER=record-start-to-user^s^1,)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:3] ExecIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?Set(__PRE_BRIDGE_HANDLER=record-start-to-user^s^1,)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:4] ExecIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?Set(__PRE_BRIDGE_HANDLER=set_confirm_call_answered^s^1,)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:5] GosubIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?record-start-from-user,s,1(25)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:6] ExecIf("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "0?Set(DIAL_OPTIONS=tU(handle-pre-bridge^s^1))") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:7] Set("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "DIAL_OPTIONS=tb(handle-pre-dial^s^1)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:8] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "tb(handle-pre-dial^s^1)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@do-dial-options:9] Return("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [dddddddddd@app-queue-to-agent-real:4] Dial("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "PJSIP/wid123,600,tb(handle-pre-dial^s^1)") in new stack [2017-05-30 16:03:29] VERBOSE[21372][C-00000345] app_queue.c: Local/c5u25q4@company_5-queue-to-agent-000004a5;1 connected line has changed. Saving it until answer for Local/6000@from-company_5-atxfer-000004a2;2 [2017-05-30 16:03:29] VERBOSE[21372][C-00000345] app_queue.c: Local/c5u25q4@company_5-queue-to-agent-000004a5;1 is ringing [2017-05-30 16:03:33] VERBOSE[22777][C-00000345] app_dial.c: PJSIP/wid123-00000a4e answered Local/c5u25q4@company_5-queue-to-agent-000004a5;2 [2017-05-30 16:03:33] VERBOSE[21372][C-00000345] app_queue.c: Local/c5u25q4@company_5-queue-to-agent-000004a5;1 answered Local/6000@from-company_5-atxfer-000004a2;2 [2017-05-30 16:03:33] VERBOSE[22777][C-00000345] bridge_channel.c: Channel Local/c5u25q4@company_5-queue-to-agent-000004a5;2 joined 'simple_bridge' basic-bridge [2017-05-30 16:03:33] VERBOSE[22786][C-00000345] bridge_channel.c: Channel Local/c5u25q4@company_5-queue-to-agent-000004a5;1 joined 'simple_bridge' basic-bridge <9476770e-9698-478a-8a9a-3f50319b0792> [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] bridge_channel.c: Channel Local/c5u25q4@company_5-queue-to-agent-000004a5;2 left 'simple_bridge' basic-bridge [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Spawn extension (app-queue-to-agent-real, dddddddddd, 4) exited non-zero on 'Local/c5u25q4@company_5-queue-to-agent-000004a5;2' [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Executing [h@app-queue-to-agent-real:1] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "") in new stack [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Executing [h@app-queue-to-agent-real:2] Goto("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "ngpbx-hangup-call,hangup,1") in new stack [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Executing [hangup@ngpbx-hangup-call:1] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "") in new stack [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Executing [hangup@ngpbx-hangup-call:2] NoOp("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "QOS=") in new stack [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Executing [hangup@ngpbx-hangup-call:3] Hangup("Local/c5u25q4@company_5-queue-to-agent-000004a5;2", "") in new stack [2017-05-30 16:04:54] VERBOSE[22777][C-00000345] pbx.c: Spawn extension (ngpbx-hangup-call, hangup, 3) exited non-zero on 'Local/c5u25q4@company_5-queue-to-agent-000004a5;2' [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] app_stack.c: PJSIP/wid123-00000a4e Internal Gosub(handle-pre-dial,s,1) start [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:1] NoOp("PJSIP/wid123-00000a4e", "PRE_DIAL_HANDLER: handler^agent_call^1,") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:2] Gosub("PJSIP/wid123-00000a4e", "add-x-channelid,s,1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@add-x-channelid:1] ExecIf("PJSIP/wid123-00000a4e", "1?Set(PJSIP_HEADER(add,X-ChannelID)=s2-1496153009.5879)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@add-x-channelid:2] ExecIf("PJSIP/wid123-00000a4e", "1?Set(PJSIP_HEADER(add,X-GUID)=e460fa0d9fac584ea448fa0e51d17100b8d0eef0)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@add-x-channelid:3] Return("PJSIP/wid123-00000a4e", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:3] While("PJSIP/wid123-00000a4e", "1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:4] NoOp("PJSIP/wid123-00000a4e", "var is handler^agent_call^1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:5] Gosub("PJSIP/wid123-00000a4e", "handler,agent_call,1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:1] NoOp("PJSIP/wid123-00000a4e", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:2] ExecIf("PJSIP/wid123-00000a4e", "0?DumpChan()") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:3] GotoIf("PJSIP/wid123-00000a4e", "0?pickup") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:4] ExecIf("PJSIP/wid123-00000a4e", "39?UserEvent(AgentCalled,u_Queue: 4,u_Interface: Local/c5u25q4@company_5-queue-to-agent)") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:5] Set("PJSIP/wid123-00000a4e", "CHANNEL(hangup_handler_push)=queue-agent-hangup-handler,s,1") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [agent_call@handler:6] Return("PJSIP/wid123-00000a4e", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:6] EndWhile("PJSIP/wid123-00000a4e", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:3] While("PJSIP/wid123-00000a4e", "0") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] pbx.c: Executing [s@handle-pre-dial:7] Return("PJSIP/wid123-00000a4e", "") in new stack [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] app_stack.c: Spawn extension (from-company_5, dddddddddd, 1) exited non-zero on 'PJSIP/wid123-00000a4e' [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] app_stack.c: PJSIP/wid123-00000a4e Internal Gosub(handle-pre-dial,s,1) complete GOSUB_RETVAL= [2017-05-30 16:03:29] VERBOSE[22777][C-00000345] app_dial.c: PJSIP/wid123-00000a4e is ringing [2017-05-30 16:03:33] VERBOSE[22777][C-00000345] app_dial.c: PJSIP/wid123-00000a4e answered Local/c5u25q4@company_5-queue-to-agent-000004a5;2 [2017-05-30 16:03:33] VERBOSE[22784][C-00000345] bridge_channel.c: Channel PJSIP/wid123-00000a4e joined 'simple_bridge' basic-bridge [2017-05-30 16:04:54] VERBOSE[22784][C-00000345] bridge_channel.c: Channel PJSIP/wid123-00000a4e left 'simple_bridge' basic-bridge