[2019-05-14 09:15:40] VERBOSE[39826][C-0000434b] netsock2.c: Using SIP RTP CoS mark 5 [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKED@from-voip-provider:1] NoOp("SIP/siptrunk-000074f4", "Inbound Call") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:2] Set("SIP/siptrunk-000074f4", "CDR(type)=inbound") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:3] Set("SIP/siptrunk-000074f4", "XCALLY-MOTION-ANSWER=0") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:4] Set("SIP/siptrunk-000074f4", "XCALLY-MOTION-PROGRESS=0") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:5] Set("SIP/siptrunk-000074f4", "MONITOR_OPTIONS=ab") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:6] Set("SIP/siptrunk-000074f4", "CHANNEL(language)=se") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] pbx_realtime.c: Executing [MASKEDNUMBER@from-voip-provider:7] AGI("SIP/siptrunk-000074f4", "agi://127.0.0.1/square,C") [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: START CALLY SQUARE [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: Answer [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: AGI Script Executing Application: (AGI) Options: (agi://127.0.0.1/square,GENERAL_cleanDNID,C) [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: START CALLY SQUARE [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: Answer [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: math MASKEDNUMBER.substr(0,1) [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: EVAL CONDITION 0 == 0 true [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: math MASKEDNUMBER.substr(1,100) [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: end [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,GENERAL_cleanDNID,C: GOTO from-voip-provider MASKEDNUMBER 8 [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: AGI Script agi://127.0.0.1/square completed, returning 0 [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: Executed command AGI GENERAL_cleanDNID [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: Always open [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,*,12-28,feb false [2019-05-14 09:15:40] VERBOSE[55542][C-0000434b] file.c: Playing '/var/opt/motion2/server/files/sounds/converted/ec_Meny_20190401-1554099896078.slin' (language 'se') [2019-05-14 09:15:57] DTMF[55542][C-0000434b] channel.c: DTMF begin '0' received on SIP/siptrunk-000074f4 [2019-05-14 09:15:57] DTMF[55542][C-0000434b] channel.c: DTMF begin ignored '0' on SIP/siptrunk-000074f4 [2019-05-14 09:15:57] DTMF[55542][C-0000434b] channel.c: DTMF end '0' received on SIP/siptrunk-000074f4, duration 140 ms [2019-05-14 09:15:57] DTMF[55542][C-0000434b] channel.c: DTMF end passthrough '0' on SIP/siptrunk-000074f4 [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME 09:00-18:00,mon-fri,*,* true [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME 15:00-23:00,thu,18,apr false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,fri,19,apr false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,mon,22,apr false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME 15:00-23:00,tue,30,apr false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,wed,1,may false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,thu,30,may false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME *,thu,6,jun false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: sh command: node /usr/src/ag-queue-depth/con_get_queue_depth.js EC_Kampanj result on variable: VAR2 [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME 16:45-21:00,mon-fri,*,* false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: IFTIME 14:00-23:00,*,18,apr false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: EVAL CONDITION Number(0) >= Number(100) false [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: sh command: echo Samtal [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_agi.c: AGI Script Executing Application: (QUEUE) Options: (EC_Kampanj,xX,,,28800,,,MMSUB,,) [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] res_musiconhold.c: Started music on hold, class 'Ringback', on channel 'SIP/siptrunk-000074f4' [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] netsock2.c: Using SIP RTP CoS mark 5 [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] app_queue.c: Called SIP/agent97 [2019-05-14 09:15:57] VERBOSE[55542][C-0000434b] app_queue.c: SIP/agent97-000074fe is ringing [2019-05-14 09:16:02] VERBOSE[55542][C-0000434b] app_queue.c: SIP/agent97-000074fe answered SIP/siptrunk-000074f4 [2019-05-14 09:16:02] VERBOSE[55542][C-0000434b] res_musiconhold.c: Stopped music on hold on SIP/siptrunk-000074f4 [2019-05-14 09:16:02] VERBOSE[55542][C-0000434b] app_stack.c: SIP/agent97-000074fe Internal Gosub(MMSUB,s,1) start [2019-05-14 09:16:02] ERROR[55542][C-0000434b] app_stack.c: Attempt to reach a non-existent destination for Gosub: (Context:MMSUB, Extension:s, Priority:1) [2019-05-14 09:16:02] VERBOSE[55970][C-0000434b] bridge_channel.c: Channel SIP/agent97-000074fe joined 'simple_bridge' basic-bridge <0b50880b-3f3b-4432-acd8-26de5db5e79b> [2019-05-14 09:16:02] VERBOSE[55542][C-0000434b] bridge_channel.c: Channel SIP/siptrunk-000074f4 joined 'simple_bridge' basic-bridge <0b50880b-3f3b-4432-acd8-26de5db5e79b> [2019-05-14 09:23:20] DTMF[55970][C-0000434b] channel.c: DTMF begin '9' received on SIP/agent97-000074fe [2019-05-14 09:23:20] DTMF[55970][C-0000434b] channel.c: DTMF begin passthrough '9' on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end '9' received on SIP/agent97-000074fe, duration 200 ms [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end accepted with begin '9' on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end passthrough '9' on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF begin '2' received on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF begin passthrough '2' on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end '2' received on SIP/agent97-000074fe, duration 200 ms [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end accepted with begin '2' on SIP/agent97-000074fe [2019-05-14 09:23:21] DTMF[55970][C-0000434b] channel.c: DTMF end passthrough '2' on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF begin '4' received on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF begin passthrough '4' on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF end '4' received on SIP/agent97-000074fe, duration 200 ms [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF end accepted with begin '4' on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF end passthrough '4' on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF begin '2' received on SIP/agent97-000074fe [2019-05-14 09:23:22] DTMF[55970][C-0000434b] channel.c: DTMF begin passthrough '2' on SIP/agent97-000074fe [2019-05-14 09:23:23] DTMF[55970][C-0000434b] channel.c: DTMF end '2' received on SIP/agent97-000074fe, duration 200 ms [2019-05-14 09:23:23] DTMF[55970][C-0000434b] channel.c: DTMF end accepted with begin '2' on SIP/agent97-000074fe [2019-05-14 09:23:23] DTMF[55970][C-0000434b] channel.c: DTMF end passthrough '2' on SIP/agent97-000074fe [2019-05-14 09:23:23] VERBOSE[55542][C-0000434b] res_musiconhold.c: Started music on hold, class 'default', on channel 'SIP/siptrunk-000074f4' [2019-05-14 09:23:24] VERBOSE[39826][C-000043aa] netsock2.c: Using SIP RTP CoS mark 5 [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:1] NoOp("SIP/agent97-000075b7", "Internal Call") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:2] Set("SIP/agent97-000075b7", "CDR(type)=internal") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:3] Set("SIP/agent97-000075b7", "XCALLY-MOTION-ANSWER=0") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:4] Set("SIP/agent97-000075b7", "XCALLY-MOTION-PROGRESS=0") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:5] Set("SIP/agent97-000075b7", "MONITOR_OPTIONS=ab") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:6] GotoIfTime("SIP/agent97-000075b7", "09:00-18:00,mon-fri,*,*?from-sip,9242,7:from-sip,9242,8") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_builtins.c: Goto (from-sip,9242,7) [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:7] Set("SIP/agent97-000075b7", "CHANNEL(language)=se") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:8] GotoIfTime("SIP/agent97-000075b7", "09:00-18:00,mon-fri,*,*?from-sip,9242,9:from-sip,9242,12") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_builtins.c: Goto (from-sip,9242,9) [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:9] ExecIf("SIP/agent97-000075b7", "1?Answer") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:10] Set("SIP/agent97-000075b7", "XCALLY-MOTION-ANSWER=1") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] pbx_realtime.c: Executing [9242@from-sip:11] Queue("SIP/agent97-000075b7", "EC_Kundservice,xX,,,28800,,,,,") [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] res_musiconhold.c: Started music on hold, class 'Ringback', on channel 'SIP/agent97-000075b7' [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] netsock2.c: Using SIP RTP CoS mark 5 [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] app_queue.c: Called SIP/agent101 [2019-05-14 09:23:24] VERBOSE[63090][C-000043aa] app_queue.c: SIP/agent101-000075b8 is ringing [2019-05-14 09:23:29] VERBOSE[63090][C-000043aa] app_queue.c: SIP/agent101-000075b8 answered SIP/agent97-000075b7 [2019-05-14 09:23:29] VERBOSE[63090][C-000043aa] res_musiconhold.c: Stopped music on hold on SIP/agent97-000075b7 [2019-05-14 09:23:29] VERBOSE[55542][C-0000434b] res_musiconhold.c: Stopped music on hold on SIP/siptrunk-000074f4 [2019-05-14 09:23:29] VERBOSE[55970][C-0000434b] bridge_channel.c: Channel SIP/agent97-000074fe left 'simple_bridge' basic-bridge <0b50880b-3f3b-4432-acd8-26de5db5e79b> [2019-05-14 09:23:29] VERBOSE[55542][C-0000434b] bridge_channel.c: Channel SIP/siptrunk-000074f4 left 'simple_bridge' basic-bridge <0b50880b-3f3b-4432-acd8-26de5db5e79b> [2019-05-14 09:23:29] VERBOSE[63158][C-000043aa] bridge_channel.c: Channel SIP/agent101-000075b8 joined 'simple_bridge' basic-bridge [2019-05-14 09:23:29] VERBOSE[63090][C-000043aa] bridge_channel.c: Channel SIP/agent97-000075b7 joined 'simple_bridge' basic-bridge [2019-05-14 09:23:29] VERBOSE[55542][C-0000434b] res_agi.c: agi://127.0.0.1/square,C: GOTO from-voip-provider MASKEDNUMBER 8 [2019-05-14 09:23:29] VERBOSE[55542][C-0000434b] res_agi.c: AGI Script agi://127.0.0.1/square completed, returning 4 [2019-05-14 09:23:29] VERBOSE[55542][C-0000434b] pbx.c: Spawn extension (from-voip-provider, MASKEDNUMBER, 7) exited non-zero on 'SIP/agent97-000075b7'