[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:1] NoOp("SIP/10-00000000", "Dialing 0644XXXXX33 from 10") in new stack[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:2] Gosub("SIP/10-00000000", "sub-set-global-vars,s,1(0644XXXXX33,parking-1)") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:1] NoOp("SIP/10-00000000", "Setting Global Vars") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:2] Set("SIP/10-00000000", "__PICKUPMARK=0644XXXXX33") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:3] Set("SIP/10-00000000", "__PARKINGLOT=parking-1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:4] Set("SIP/10-00000000", "__DYNAMIC_FEATURES=custom-features") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:5] Set("SIP/10-00000000", "ICALL=no") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-global-vars:6] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:3] Gosub("SIP/10-00000000", "sub-set-call-vars,s,1(0a5c53d509ae2b36,0644XXXXX33,all,cos-all,ARS-all)") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:1] NoOp("SIP/10-00000000", "Setting Call Vars") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:2] Set("SIP/10-00000000", "_TENANT=0a5c53d509ae2b36") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:3] Set("SIP/10-00000000", "_CALL_DESTINATION=0644XXXXX33") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:4] Set("SIP/10-00000000", "_COS_ID=all") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:5] Set("SIP/10-00000000", "_COS_NAME=cos-all") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:6] Set("SIP/10-00000000", "_ARS=ARS-all") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:7] Set("SIP/10-00000000", "CDR(tenant)=ombutel") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:8] Set("SIP/10-00000000", "CDR(destination)=0644XXXXX33") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-set-call-vars:9] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:4] Gosub("SIP/10-00000000", "sub-construct-cid,s,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:1] NoOp("SIP/10-00000000", "Building CID") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:2] Set("SIP/10-00000000", "_CALL_SOURCE=10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:3] GotoIf("SIP/10-00000000", "0?return") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:4] Gosub("SIP/10-00000000", "sub-get-device-tree,s,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:1] NoOp("SIP/10-00000000", "Configuring Device Tree") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:2] Set("SIP/10-00000000", "DEV_TECHNOLOGY=SIP") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:3] GosubIf("SIP/10-00000000", "0?s-local,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:4] GotoIf("SIP/10-00000000", "0?return") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:5] GotoIf("SIP/10-00000000", "0?:digital") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx_builtins.c: Goto (sub-get-device-tree,s,8)
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:8] Set("SIP/10-00000000", "DEV_USER=10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:9] Set("SIP/10-00000000", "INTERFACE=SIP/10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:10] Set("SIP/10-00000000", "DEV_TREE=devices/SIP/10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-get-device-tree:11] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:5] GotoIf("SIP/10-00000000", "0?return") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:6] Set("SIP/10-00000000", "_CALL_SOURCE=10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:7] ExecIf("SIP/10-00000000", "1?Set(CALLERID(all)="Zentrale" <10>)") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:8] Set("SIP/10-00000000", "_CID_CONSTRUCTED=yes") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:9] NoOp("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:10] Set("SIP/10-00000000", "CDR(source)=10") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-construct-cid:11] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:5] Gosub("SIP/10-00000000", "sub-lockphone-check,s,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:1] NoOp("SIP/10-00000000", "SUB: LOCK PHONE CHECK") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:2] GotoIf("SIP/10-00000000", "0?unlock") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:3] GotoIf("SIP/10-00000000", "0?unlock") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:4] GotoIf("SIP/10-00000000", "0?unlock") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:5] GotoIf("SIP/10-00000000", "0?unlock") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:6] GotoIf("SIP/10-00000000", "0?:unlock") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx_builtins.c: Goto (sub-lockphone-check,s,12)
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-lockphone-check:12] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:6] Gosub("SIP/10-00000000", "sub-local-dialing,s,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-local-dialing:1] NoOp("SIP/10-00000000", "Trying to determine if is a local extension") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-local-dialing:2] GotoIf("SIP/10-00000000", "0?:return") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx_builtins.c: Goto (sub-local-dialing,s,4)
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@sub-local-dialing:4] Return("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all:7] GosubIf("SIP/10-00000000", "0?:cos-all-post,0644XXXXX33,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all-post:1] NoOp("SIP/10-00000000", "") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [0644XXXXX33@cos-all-post:2] Goto("SIP/10-00000000", "invalid-dest-cos,s,1") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx_builtins.c: Goto (invalid-dest-cos,s,1)
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@invalid-dest-cos:1] NoOp("SIP/10-00000000", "Invalid Route to Dial in COS") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@invalid-dest-cos:2] GotoIf("SIP/10-00000000", "0?end") in new stack
[2017-04-10 19:34:12] VERBOSE[1747][C-00000000] pbx.c: Executing [s@invalid-dest-cos:3] Playback("SIP/10-00000000", "silence/1&cannot-complete-as-dialed&check-number-dial-again") in new stack
[2017-04-10 19:34:13] VERBOSE[1747][C-00000000] file.c: <SIP/10-00000000> Playing 'silence/1.ulaw' (language 'en')
[2017-04-10 19:34:14] VERBOSE[1747][C-00000000] file.c: <SIP/10-00000000> Playing 'cannot-complete-as-dialed.ulaw' (language 'en')
[2017-04-10 19:34:15] VERBOSE[1747][C-00000000] file.c: <SIP/10-00000000> Playing 'check-number-dial-again.ulaw' (language 'en')