PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Caller ID name is '9162056358' number is '9162056358'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CW Ignore is:
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CF Ignore is:
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Added extension 1301 to extension map
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Added extension 1302 to extension map
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1301 cf is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1302 cf is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1301 do not disturb is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1302 do not disturb is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: dbset CALLTRACE/1301 to 9162056358
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: dbset CALLTRACE/1302 to 9162056358
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Filtered ARG3: 1301-1302
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: <SIP/WEST CALL-00000050>AGI Script dialparties.agi completed, returning 0
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:9] NoOp("SIP/WEST CALL-00000050", "Returned from dialparties with groups to dial") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:10] Set("SIP/WEST CALL-00000050", "LOOPCNT=2") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:11] Set("SIP/WEST CALL-00000050", "ITER=1") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:12] Set("SIP/WEST CALL-00000050", "EXTTOCALL=1301") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/WEST CALL-00000050", "Working with 1301") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:14] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:15] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:16] Set("SIP/WEST CALL-00000050", "ITER=2") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:17] GotoIf("SIP/WEST CALL-00000050", "1?ndloopbegin") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx_builtins.c: Goto (macro-dial,s,12)
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:12] Set("SIP/WEST CALL-00000050", "EXTTOCALL=1302") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/WEST CALL-00000050", "Working with 1302") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:14] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:15] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:16] Set("SIP/WEST CALL-00000050", "ITER=3") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:17] GotoIf("SIP/WEST CALL-00000050", "0?ndloopbegin") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:18] Macro("SIP/WEST CALL-00000050", "dial-ringall-predial-hook,") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/WEST CALL-00000050", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:19] Dial("SIP/WEST CALL-00000050", "SIP/1301&SIP/1302,20,tmM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1301-00000051 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/1301-00000051", "Applying SIP Headers to channel") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/1301-00000051", "SIPHEADERKEYS=") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/1301-00000051", "0") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_while.c: Jumping to priority 6
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:7] Return("SIP/1301-00000051", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: Spawn extension (from-internal, 1300, 1) exited non-zero on 'SIP/1301-00000051'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1301-00000051 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1302-00000052 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/1302-00000052", "Applying SIP Headers to channel") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/1302-00000052", "SIPHEADERKEYS=") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/1302-00000052", "0") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_while.c: Jumping to priority 6
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:7] Return("SIP/1302-00000052", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: Spawn extension (from-internal, 1300, 1) exited non-zero on 'SIP/1302-00000052'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1302-00000052 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: Called SIP/1301
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: Called SIP/1302
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_musiconhold.c: Started music on hold, class 'default', on channel 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:13] WARNING[15440][C-0000001f] translate.c: no samples for alawtolin
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1302-00000052 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:14] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1302-00000052 is ringing
[2017-08-02 10:46:14] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 is ringing
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 answered SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:1] Set("SIP/1301-00000051", "__MACRO_RESULT=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:2] Set("SIP/1301-00000051", "CFIGNORE=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:3] Set("SIP/1301-00000051", "MASTER_CHANNEL(CFIGNORE)=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:4] Set("SIP/1301-00000051", "FORWARD_CONTEXT=from-internal") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:5] Set("SIP/1301-00000051", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("SIP/1301-00000051", "blkvm-clr,") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/1301-00000051", "SHARED(BLKVM,SIP/WEST CALL-00000050)=") in new stack
[2017-08-02 10:46:24] WARNING[15440][C-0000001f] pbx_variables.c: Please avoid unnecessary spaces on variables as it may lead to unexpected results ('SHARED(BLKVM,SIP/WEST CALL-00000050)' set to '').
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/1301-00000051", "GOSUB_RETVAL=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/1301-00000051", "") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("SIP/1301-00000051", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=1301)") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("SIP/1301-00000051", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Ресепшен АРМА1)") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] res_musiconhold.c: Stopped music on hold on SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15482][C-0000001f] bridge_channel.c: Channel SIP/1301-00000051 joined 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] bridge_channel.c: Channel SIP/WEST CALL-00000050 joined 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15482][C-0000001f] bridge_channel.c: Channel SIP/1301-00000051 left 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] bridge_channel.c: Channel SIP/WEST CALL-00000050 left 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] app_macro.c: Spawn extension (macro-dial, s, 19) exited non-zero on 'SIP/WEST CALL-00000050' in macro 'dial'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Spawn extension (ext-group, 1300, 14) exited non-zero on 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [h@ext-group:1] Macro("SIP/WEST CALL-00000050", "hangupcall,") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/WEST CALL-00000050", "1?theend") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/WEST CALL-00000050", "0?Set(CDR(recordingfile)=)") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:4] Hangup("SIP/WEST CALL-00000050", "") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/WEST CALL-00000050' in macro 'hangupcall'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:38] VERBOSE[15441][C-0000001f] app_mixmonitor.c: MixMonitor close filestream (mixed)
[2017-08-02 10:46:38] VERBOSE[15441][C-0000001f] app_mixmonitor.c: End MixMonitor Recording SIP/WEST CALL-00000050
[2017-08-02 10:46:43] VERBOSE[15404] asterisk.c: Remote UNIX connection disconnected
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CW Ignore is:
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CF Ignore is:
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Added extension 1301 to extension map
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Added extension 1302 to extension map
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1301 cf is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1302 cf is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1301 do not disturb is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Extension 1302 do not disturb is disabled
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: dbset CALLTRACE/1301 to 9162056358
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: dbset CALLTRACE/1302 to 9162056358
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: dialparties.agi: Filtered ARG3: 1301-1302
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_agi.c: <SIP/WEST CALL-00000050>AGI Script dialparties.agi completed, returning 0
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:9] NoOp("SIP/WEST CALL-00000050", "Returned from dialparties with groups to dial") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:10] Set("SIP/WEST CALL-00000050", "LOOPCNT=2") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:11] Set("SIP/WEST CALL-00000050", "ITER=1") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:12] Set("SIP/WEST CALL-00000050", "EXTTOCALL=1301") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/WEST CALL-00000050", "Working with 1301") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:14] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:15] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:16] Set("SIP/WEST CALL-00000050", "ITER=2") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:17] GotoIf("SIP/WEST CALL-00000050", "1?ndloopbegin") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx_builtins.c: Goto (macro-dial,s,12)
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:12] Set("SIP/WEST CALL-00000050", "EXTTOCALL=1302") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/WEST CALL-00000050", "Working with 1302") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:14] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:15] ExecIf("SIP/WEST CALL-00000050", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:16] Set("SIP/WEST CALL-00000050", "ITER=3") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:17] GotoIf("SIP/WEST CALL-00000050", "0?ndloopbegin") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:18] Macro("SIP/WEST CALL-00000050", "dial-ringall-predial-hook,") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/WEST CALL-00000050", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-dial:19] Dial("SIP/WEST CALL-00000050", "SIP/1301&SIP/1302,20,tmM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1301-00000051 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/1301-00000051", "Applying SIP Headers to channel") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/1301-00000051", "SIPHEADERKEYS=") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/1301-00000051", "0") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_while.c: Jumping to priority 6
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:7] Return("SIP/1301-00000051", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: Spawn extension (from-internal, 1300, 1) exited non-zero on 'SIP/1301-00000051'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1301-00000051 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1302-00000052 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/1302-00000052", "Applying SIP Headers to channel") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/1302-00000052", "SIPHEADERKEYS=") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/1302-00000052", "0") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_while.c: Jumping to priority 6
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@func-apply-sipheaders:7] Return("SIP/1302-00000052", "") in new stack
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: Spawn extension (from-internal, 1300, 1) exited non-zero on 'SIP/1302-00000052'
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_stack.c: SIP/1302-00000052 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: Called SIP/1301
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: Called SIP/1302
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] res_musiconhold.c: Started music on hold, class 'default', on channel 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:13] WARNING[15440][C-0000001f] translate.c: no samples for alawtolin
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1302-00000052 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:13] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:14] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1302-00000052 is ringing
[2017-08-02 10:46:14] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 is ringing
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 connected line has changed. Saving it until answer for SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] app_dial.c: SIP/1301-00000051 answered SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:1] Set("SIP/1301-00000051", "__MACRO_RESULT=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:2] Set("SIP/1301-00000051", "CFIGNORE=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:3] Set("SIP/1301-00000051", "MASTER_CHANNEL(CFIGNORE)=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:4] Set("SIP/1301-00000051", "FORWARD_CONTEXT=from-internal") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:5] Set("SIP/1301-00000051", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("SIP/1301-00000051", "blkvm-clr,") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/1301-00000051", "SHARED(BLKVM,SIP/WEST CALL-00000050)=") in new stack
[2017-08-02 10:46:24] WARNING[15440][C-0000001f] pbx_variables.c: Please avoid unnecessary spaces on variables as it may lead to unexpected results ('SHARED(BLKVM,SIP/WEST CALL-00000050)' set to '').
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/1301-00000051", "GOSUB_RETVAL=") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/1301-00000051", "") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("SIP/1301-00000051", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=1301)") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("SIP/1301-00000051", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Ресепшен АРМА1)") in new stack
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] res_musiconhold.c: Stopped music on hold on SIP/WEST CALL-00000050
[2017-08-02 10:46:24] VERBOSE[15482][C-0000001f] bridge_channel.c: Channel SIP/1301-00000051 joined 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:24] VERBOSE[15440][C-0000001f] bridge_channel.c: Channel SIP/WEST CALL-00000050 joined 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15482][C-0000001f] bridge_channel.c: Channel SIP/1301-00000051 left 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] bridge_channel.c: Channel SIP/WEST CALL-00000050 left 'simple_bridge' basic-bridge <d4cc1c67-87cd-433d-9664-5f4e76afb749>
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] app_macro.c: Spawn extension (macro-dial, s, 19) exited non-zero on 'SIP/WEST CALL-00000050' in macro 'dial'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Spawn extension (ext-group, 1300, 14) exited non-zero on 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [h@ext-group:1] Macro("SIP/WEST CALL-00000050", "hangupcall,") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/WEST CALL-00000050", "1?theend") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/WEST CALL-00000050", "0?Set(CDR(recordingfile)=)") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Executing [s@macro-hangupcall:4] Hangup("SIP/WEST CALL-00000050", "") in new stack
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/WEST CALL-00000050' in macro 'hangupcall'
[2017-08-02 10:46:38] VERBOSE[15440][C-0000001f] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/WEST CALL-00000050'
[2017-08-02 10:46:38] VERBOSE[15441][C-0000001f] app_mixmonitor.c: MixMonitor close filestream (mixed)
[2017-08-02 10:46:38] VERBOSE[15441][C-0000001f] app_mixmonitor.c: End MixMonitor Recording SIP/WEST CALL-00000050
[2017-08-02 10:46:43] VERBOSE[15404] asterisk.c: Remote UNIX connection disconnected