Moved system to different server, restored backup, now no phones seem to work

travis_farmer · November 17, 2018, 10:55am

i changed the server that my Sangoma/FreePBX system runs on, and after running all updates (system and modules), i restored the settings from a full backup (ran just before the change). it looked like a good restore, though the only phone that i can get to connect is a Software phone on my laptop. on the hardware phones, i changed the IP to match the new (to me) server.
the Software phone is fully functional, but when the hardware phones try to register, i get this in /var/log/asterisk/full
[2018-11-17 10:38:27] VERBOSE[13545] chan_sip.c: Registered SIP ‘1001’ at 10.142.174.127:5060
[2018-11-17 10:38:27] WARNING[13402] db.c: Error executing SQL (COMMIT): database is locked
i can post the full log snippet from trying to place a call on the hardware phone (it does register, but will not take or place calls), but the above log snippet looks key (at least it does to me).

~Travis

travis_farmer · November 17, 2018, 11:14am

[2018-11-17 11:09:22] VERBOSE[13545] chan_sip.c: Registered SIP '1001' at 10.142.174.127:5060
[2018-11-17 11:09:22] NOTICE[13545] chan_sip.c: Peer '1001' is now Reachable. (16ms / 2000ms)
[2018-11-17 11:09:42] VERBOSE[22515] pbx_variables.c: Setting global variable 'SIPDOMAIN' to '10.142.174.194'
[2018-11-17 11:09:42] VERBOSE[22515] netsock2.c: Using SIP RTP Audio TOS bits 184
[2018-11-17 11:09:42] VERBOSE[22515] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2018-11-17 11:09:42] VERBOSE[22515] netsock2.c: Using SIP RTP Audio CoS mark 5
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [1001@from-internal:1] GotoIf("PJSIP/1009-0000000a", "1?ext-local,1001,1:followme-check,1001,1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (ext-local,1001,1)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [1001@ext-local:1] Set("PJSIP/1009-0000000a", "__RINGTIMER=10") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [1001@ext-local:2] Macro("PJSIP/1009-0000000a", "exten-vm,1001,1001,0,0,0") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/1009-0000000a", "user-callerid,") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/1009-0000000a", "TOUCH_MONITOR=1542452982.64") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/1009-0000000a", "AMPUSER=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/1009-0000000a", "0?report") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("PJSIP/1009-0000000a", "1?Set(REALCALLERIDNUM=1009)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/1009-0000000a", "AMPUSER=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("PJSIP/1009-0000000a", "0?limit") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/1009-0000000a", "AMPUSERCIDNAME=Travis Laptop") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("PJSIP/1009-0000000a", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("PJSIP/1009-0000000a", "0?report") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/1009-0000000a", "AMPUSERCID=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/1009-0000000a", "__DIAL_OPTIONS=HhTtr") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/1009-0000000a", "CALLERID(all)="Travis Laptop" <1009>") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/1009-0000000a", "0?limit") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/1009-0000000a", "0?Set(GROUP(concurrency_limit)=1009)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("PJSIP/1009-0000000a", "0?Set(CHANNEL(language)=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:16] NoOp("PJSIP/1009-0000000a", "Macro Depth is 2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("PJSIP/1009-0000000a", "1?report2:macroerror") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("PJSIP/1009-0000000a", "0?continue") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("PJSIP/1009-0000000a", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/1009-0000000a", "__TTL=64") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:21] GotoIf("PJSIP/1009-0000000a", "1?continue") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:37] Set("PJSIP/1009-0000000a", "CALLERID(number)=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:38] Set("PJSIP/1009-0000000a", "CALLERID(name)=Travis Laptop") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("PJSIP/1009-0000000a", "0?cnum") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:40] Set("PJSIP/1009-0000000a", "CDR(cnam)=Travis Laptop") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:41] Set("PJSIP/1009-0000000a", "CDR(cnum)=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:42] Set("PJSIP/1009-0000000a", "CHANNEL(language)=en") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/1009-0000000a", "RingGroupMethod=none") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/1009-0000000a", "__EXTTOCALL=1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/1009-0000000a", "__PICKUPMARK=1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/1009-0000000a", "RT=10") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/1009-0000000a", "0?Macro(vm,1001,DIRECTDIAL,)") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:8] ExecIf("PJSIP/1009-0000000a", "0?Gosub(ext-intercom,*801001,1())") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:9] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:10] ExecIf("PJSIP/1009-0000000a", "0?ChanSpy(SIP/1001,q)") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] WARNING[29234][C-0000000c] chan_sip.c: This function can only be used on SIP channels.
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:12] ExecIf("PJSIP/1009-0000000a", "0?Macro(vm,1001,DIRECTDIAL,)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:13] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:14] ExecIf("PJSIP/1009-0000000a", "0?Gosub(ext-intercom,*801001,1())") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:15] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:16] ExecIf("PJSIP/1009-0000000a", "0?ChanSpy(SIP/1001,q)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:17] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:18] Gosub("PJSIP/1009-0000000a", "sub-record-check,s,1(exten,1001,dontcare)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/1009-0000000a", "0?initialized") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/1009-0000000a", "__REC_STATUS=INITIALIZED") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/1009-0000000a", "NOW=1542452982") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/1009-0000000a", "__DAY=17") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/1009-0000000a", "__MONTH=11") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/1009-0000000a", "__YEAR=2018") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/1009-0000000a", "__TIMESTR=20181117-110942") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/1009-0000000a", "__FROMEXTEN=1009") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/1009-0000000a", "__MON_FMT=wav") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/1009-0000000a", "Recordings initialized") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/1009-0000000a", "0?Set(ARG3=dontcare)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/1009-0000000a", "REC_POLICY_MODE_SAVE=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/1009-0000000a", "0?Set(REC_STATUS=NO)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/1009-0000000a", "5?checkaction") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/1009-0000000a", "1?sub-record-check,exten,1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/1009-0000000a", "Exten Recording Check between 1009 and 1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/1009-0000000a", "CALLTYPE=internal") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/1009-0000000a", "0?Set(CALLTYPE=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/1009-0000000a", "CALLEE=dontcare") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/1009-0000000a", "0?Set(CALLEE=dontcare)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/1009-0000000a", "0?callee") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/1009-0000000a", "1?caller") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/1009-0000000a", "RECMODE=dontcare") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/1009-0000000a", "0?Set(RECMODE=dontcare)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/1009-0000000a", "1?Set(RECMODE=dontcare)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/1009-0000000a", "recordcheck,1(dontcare,internal,1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/1009-0000000a", "Starting recording check against dontcare") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/1009-0000000a", "dontcare") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:19] GotoIf("PJSIP/1009-0000000a", "1?macrodial") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-exten-vm,s,25)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:25] GosubIf("PJSIP/1009-0000000a", "0?clrheader,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:26] Macro("PJSIP/1009-0000000a", "dial-one,10,HhTtr,1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/1009-0000000a", "DEXTEN=1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:2] UserEvent("PJSIP/1009-0000000a", "zulu-inbound-call,type:macro-dial-one,from:1009,to:1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:3] ExecIf("PJSIP/1009-0000000a", "0?Set(__EXTTOCALL=1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:4] Set("PJSIP/1009-0000000a", "DIALSTATUS_CW=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/1009-0000000a", "0?screen,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/1009-0000000a", "0?cf,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:7] GotoIf("PJSIP/1009-0000000a", "1?skip1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,s,10)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/1009-0000000a", "0?nodial") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/1009-0000000a", "0?continue") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:12] Set("PJSIP/1009-0000000a", "EXTHASCW=ENABLED") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:13] GotoIf("PJSIP/1009-0000000a", "0?next1:cwinusebusy") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,s,25)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:25] GotoIf("PJSIP/1009-0000000a", "0?next3:continue") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,s,27)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:27] GotoIf("PJSIP/1009-0000000a", "0?nodial") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:28] GosubIf("PJSIP/1009-0000000a", "1?dstring,1():dlocal,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/1009-0000000a", "DSTRING=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/1009-0000000a", "DEVICES=1001&901001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/1009-0000000a", "0?Return()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/1009-0000000a", "0?Set(DEVICES=001&901001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/1009-0000000a", "LOOPCNT=2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/1009-0000000a", "ITER=1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/1009-0000000a", "THISDIAL=SIP/1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/1009-0000000a", "1?zap2dahdi,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/1009-0000000a", "0?Return()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/1009-0000000a", "NEWDIAL=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/1009-0000000a", "LOOPCNT2=1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/1009-0000000a", "ITER2=1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/1009-0000000a", "THISPART2=SIP/1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/1009-0000000a", "0?Set(THISPART2=DAHDI/1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/1009-0000000a", "NEWDIAL=SIP/1001&") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/1009-0000000a", "ITER2=2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/1009-0000000a", "0?begin2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/1009-0000000a", "THISDIAL=SIP/1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/1009-0000000a", "1?docheck") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,dstring,15)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf("PJSIP/1009-0000000a", "0?skipset") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/1009-0000000a", "DSTRING=SIP/1001&") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:17] Set("PJSIP/1009-0000000a", "ITER=2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:18] GotoIf("PJSIP/1009-0000000a", "1?begin") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,dstring,7)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/1009-0000000a", "THISDIAL=PJSIP/901001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/1009-0000000a", "1?zap2dahdi,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/1009-0000000a", "0?Return()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/1009-0000000a", "NEWDIAL=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/1009-0000000a", "LOOPCNT2=1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/1009-0000000a", "ITER2=1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/1009-0000000a", "THISPART2=PJSIP/901001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/1009-0000000a", "0?Set(THISPART2=DAHDIIP/901001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/1009-0000000a", "NEWDIAL=PJSIP/901001&") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/1009-0000000a", "ITER2=2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/1009-0000000a", "0?begin2") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/1009-0000000a", "THISDIAL=PJSIP/901001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/1009-0000000a", "0?docheck") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:10] NoOp("PJSIP/1009-0000000a", "Debug: Found PJSIP Destination PJSIP/901001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf("PJSIP/1009-0000000a", "0?doset") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:12] NoOp("PJSIP/1009-0000000a", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:13] Set("PJSIP/1009-0000000a", "THISDIAL=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:14] ExecIf("PJSIP/1009-0000000a", "1?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf("PJSIP/1009-0000000a", "1?skipset") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-dial-one,dstring,17)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:17] Set("PJSIP/1009-0000000a", "ITER=3") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:18] GotoIf("PJSIP/1009-0000000a", "0?begin") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:19] ExecIf("PJSIP/1009-0000000a", "0?Return()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:20] Set("PJSIP/1009-0000000a", "DSTRING=SIP/1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [dstring@macro-dial-one:21] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:29] GotoIf("PJSIP/1009-0000000a", "0?nodial") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/1009-0000000a", "0?skiptrace") in new stack

travis_farmer · November 17, 2018, 11:14am

[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:31] GosubIf("PJSIP/1009-0000000a", "1?ctset,1():ctclear,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/1009-0000000a", "DB(CALLTRACE/1001)=1009") in new stack
[2018-11-17 11:09:42] WARNING[13404] db.c: Error executing SQL (COMMIT): database is locked
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:32] Set("PJSIP/1009-0000000a", "D_OPTIONS=HhTtr") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:33] GosubIf("PJSIP/1009-0000000a", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:34] NoOp("PJSIP/1009-0000000a", "Blind Transfer: , Attended Transfer: , User: 1009, Alert Info: ") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:35] ExecIf("PJSIP/1009-0000000a", "1?Set(ALERT_INFO=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/1009-0000000a", "0?Set(ALERT_INFO=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/1009-0000000a", "0?Set(ALERT_INFO=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/1009-0000000a", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/1009-0000000a", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:40] GosubIf("PJSIP/1009-0000000a", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:41] ExecIf("PJSIP/1009-0000000a", "0?Set(CHANNEL(musicclass)=)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:42] GosubIf("PJSIP/1009-0000000a", "0?qwait,1()") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:43] Set("PJSIP/1009-0000000a", "__CWIGNORE=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:44] Set("PJSIP/1009-0000000a", "__KEEPCID=TRUE") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:45] GotoIf("PJSIP/1009-0000000a", "0?usegoto,1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:46] GotoIf("PJSIP/1009-0000000a", "0?godial") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:47] Gosub("PJSIP/1009-0000000a", "sub-presencestate-display,s,1(1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@sub-presencestate-display:1] Goto("PJSIP/1009-0000000a", "state-not_set,1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (sub-presencestate-display,state-not_set,1)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [state-not_set@sub-presencestate-display:1] Set("PJSIP/1009-0000000a", "PRESENCESTATE_DISPLAY=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [state-not_set@sub-presencestate-display:2] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:48] Set("PJSIP/1009-0000000a", "CONNECTEDLINE(name,i)=Travis") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:49] Set("PJSIP/1009-0000000a", "CONNECTEDLINE(num)=1001") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:50] Set("PJSIP/1009-0000000a", "D_OPTIONS=HhTtrI") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:51] Macro("PJSIP/1009-0000000a", "dialout-one-predial-hook,") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:52] ExecIf("PJSIP/1009-0000000a", "0?Set(D_OPTIONS=HhtrII)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:53] Gosub("PJSIP/1009-0000000a", "zulu-user-settings-map,s,1(1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-user-settings-map:1] GotoIf("PJSIP/1009-0000000a", "0?1001,1") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-user-settings-map:2] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:54] Gosub("PJSIP/1009-0000000a", "zulu-send-event,s,1(1001,1009,1001)") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-send-event:1] GotoIf("PJSIP/1009-0000000a", "1?skippopup") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (zulu-send-event,s,4)
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-send-event:4] NoOp("PJSIP/1009-0000000a", "No Call Pop") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-send-event:5] UserEvent("PJSIP/1009-0000000a", "zulu-call,eventtype:calling,extension:1001,type:,url:,cnam:Travis Laptop,cnum:1009,lid:1542452982.64,from:1009,to:1001}") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@zulu-send-event:6] Return("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:55] NoOp("PJSIP/1009-0000000a", "Finished") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:56] Set("PJSIP/1009-0000000a", "_zuludialopts=") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:57] AGI("PJSIP/1009-0000000a", "zulureplace-one.agi,DSTRING,90") in new stack
[2018-11-17 11:09:42] VERBOSE[29234][C-0000000c] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/zulureplace-one.agi
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] res_agi.c: zulureplace-one.agi,DSTRING,90: DIALSTRING: SIP/1001
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] res_agi.c: zulureplace-one.agi,DSTRING,90: DIALOPTS: HhTtrI
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] res_agi.c: zulureplace-one.agi,DSTRING,90: TIMEOUT: 10
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] res_agi.c: zulureplace-one.agi,DSTRING,90: NEWDIALSTRING: SIP/1001&Local/901001@zulu-mobile-phone-wait&Local/901001@zulu-mobile-phone-registered&Local/901001@zulu-desktop-phone
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] res_agi.c: <PJSIP/1009-0000000a>AGI Script zulureplace-one.agi completed, returning 0
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:58] NoOp("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:59] ExecIf("PJSIP/1009-0000000a", "0?Set(D_OPTIONS=HhTtrIg)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:60] Dial("PJSIP/1009-0000000a", "SIP/1001&Local/901001@zulu-mobile-phone-wait&Local/901001@zulu-mobile-phone-registered&Local/901001@zulu-desktop-phone,10,HhTtrIb(func-apply-sipheaders^s^1)") in new stack
[2018-11-17 11:09:43] WARNING[29234][C-0000000c] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-mobile-phone-wait-00000018;1 Internal Gosub(func-apply-sipheaders,s,1) start
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:1] UserEvent("Local/901001@zulu-mobile-phone-wait-00000018;1", "zulu-call-b,type:func-apply-sipheaders,to:1001,from:1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/901001@zulu-mobile-phone-wait-00000018;1", "Applying SIP Headers to channel") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/901001@zulu-mobile-phone-wait-00000018;1", "SIPHEADERKEYS=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/901001@zulu-mobile-phone-wait-00000018;1", "0?Set(Rheader=1)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/901001@zulu-mobile-phone-wait-00000018;1", "0") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_while.c: Jumping to priority 9
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/901001@zulu-mobile-phone-wait-00000018;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/901001@zulu-mobile-phone-wait-00000018;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/901001@zulu-mobile-phone-wait-00000018;1", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Spawn extension (zulu-mobile-phone-wait, 1001, 1) exited non-zero on 'Local/901001@zulu-mobile-phone-wait-00000018;1'
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-mobile-phone-wait-00000018;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-mobile-phone-registered-00000019;1 Internal Gosub(func-apply-sipheaders,s,1) start
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:1] UserEvent("Local/901001@zulu-mobile-phone-registered-00000019;1", "zulu-call-b,type:func-apply-sipheaders,to:1001,from:1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/901001@zulu-mobile-phone-registered-00000019;1", "Applying SIP Headers to channel") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/901001@zulu-mobile-phone-registered-00000019;1", "SIPHEADERKEYS=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/901001@zulu-mobile-phone-registered-00000019;1", "0?Set(Rheader=1)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/901001@zulu-mobile-phone-registered-00000019;1", "0") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_while.c: Jumping to priority 9
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/901001@zulu-mobile-phone-registered-00000019;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/901001@zulu-mobile-phone-registered-00000019;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/901001@zulu-mobile-phone-registered-00000019;1", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Spawn extension (zulu-mobile-phone-registered, 1001, 1) exited non-zero on 'Local/901001@zulu-mobile-phone-registered-00000019;1'
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-mobile-phone-registered-00000019;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-desktop-phone-0000001a;1 Internal Gosub(func-apply-sipheaders,s,1) start
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:1] UserEvent("Local/901001@zulu-desktop-phone-0000001a;1", "zulu-call-b,type:func-apply-sipheaders,to:1001,from:1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/901001@zulu-desktop-phone-0000001a;1", "Applying SIP Headers to channel") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/901001@zulu-desktop-phone-0000001a;1", "SIPHEADERKEYS=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/901001@zulu-desktop-phone-0000001a;1", "0?Set(Rheader=1)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/901001@zulu-desktop-phone-0000001a;1", "0") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_while.c: Jumping to priority 9
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/901001@zulu-desktop-phone-0000001a;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/901001@zulu-desktop-phone-0000001a;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/901001@zulu-desktop-phone-0000001a;1", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Spawn extension (zulu-desktop-phone, 1001, 1) exited non-zero on 'Local/901001@zulu-desktop-phone-0000001a;1'
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_stack.c: Local/901001@zulu-desktop-phone-0000001a;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_dial.c: Called Local/901001@zulu-mobile-phone-wait
[2018-11-17 11:09:43] VERBOSE[29239][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-wait:1] Stasis("Local/901001@zulu-mobile-phone-wait-00000018;2", "zulu-mobile-call-wait-processing,10,90,") in new stack
[2018-11-17 11:09:43] ERROR[29239][C-0000000c] res_stasis.c: Stasis app 'zulu-mobile-call-wait-processing' not registered
[2018-11-17 11:09:43] VERBOSE[29239][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-wait:2] GotoIf("Local/901001@zulu-mobile-phone-wait-00000018;2", "0?connected") in new stack
[2018-11-17 11:09:43] VERBOSE[29239][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-wait:3] Hangup("Local/901001@zulu-mobile-phone-wait-00000018;2", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29239][C-0000000c] pbx.c: Spawn extension (zulu-mobile-phone-wait, 901001, 3) exited non-zero on 'Local/901001@zulu-mobile-phone-wait-00000018;2'
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_dial.c: Called Local/901001@zulu-mobile-phone-registered
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_dial.c: Called Local/901001@zulu-desktop-phone
[2018-11-17 11:09:43] VERBOSE[29241][C-0000000c] pbx.c: Executing [901001@zulu-desktop-phone:1] Stasis("Local/901001@zulu-desktop-phone-0000001a;2", "zulu-desktop-call-processing,10,90,") in new stack
[2018-11-17 11:09:43] ERROR[29241][C-0000000c] res_stasis.c: Stasis app 'zulu-desktop-call-processing' not registered
[2018-11-17 11:09:43] VERBOSE[29241][C-0000000c] pbx.c: Executing [901001@zulu-desktop-phone:2] GotoIf("Local/901001@zulu-desktop-phone-0000001a;2", "0?connected") in new stack
[2018-11-17 11:09:43] VERBOSE[29241][C-0000000c] pbx.c: Executing [901001@zulu-desktop-phone:3] Hangup("Local/901001@zulu-desktop-phone-0000001a;2", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29241][C-0000000c] pbx.c: Spawn extension (zulu-desktop-phone, 901001, 3) exited non-zero on 'Local/901001@zulu-desktop-phone-0000001a;2'
[2018-11-17 11:09:43] VERBOSE[29240][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-registered:1] Stasis("Local/901001@zulu-mobile-phone-registered-00000019;2", "zulu-mobile-call-registered-processing,10,90,") in new stack
[2018-11-17 11:09:43] ERROR[29240][C-0000000c] res_stasis.c: Stasis app 'zulu-mobile-call-registered-processing' not registered
[2018-11-17 11:09:43] VERBOSE[29240][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-registered:2] GotoIf("Local/901001@zulu-mobile-phone-registered-00000019;2", "0?connected") in new stack
[2018-11-17 11:09:43] VERBOSE[29240][C-0000000c] pbx.c: Executing [901001@zulu-mobile-phone-registered:3] Hangup("Local/901001@zulu-mobile-phone-registered-00000019;2", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29240][C-0000000c] pbx.c: Spawn extension (zulu-mobile-phone-registered, 901001, 3) exited non-zero on 'Local/901001@zulu-mobile-phone-registered-00000019;2'
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] app_dial.c: No one is available to answer at this time (4:0/0/1)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:61] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:62] ExecIf("PJSIP/1009-0000000a", "0?Set(DIALSTATUS=)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:63] GosubIf("PJSIP/1009-0000000a", "0?s-NOANSWER,1()") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-dial-one:64] MacroExit("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:27] Set("PJSIP/1009-0000000a", "SV_DIALSTATUS=NOANSWER") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:28] GosubIf("PJSIP/1009-0000000a", "0?docfu,1()") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:29] GosubIf("PJSIP/1009-0000000a", "0?docfb,1()") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:30] Set("PJSIP/1009-0000000a", "DIALSTATUS=NOANSWER") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:31] ExecIf("PJSIP/1009-0000000a", "0?MacroExit()") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:32] GotoIf("PJSIP/1009-0000000a", "0?s-NOANSWER,1") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-exten-vm:33] Macro("PJSIP/1009-0000000a", "vm,1001,NOANSWER,") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-vm:1] Macro("PJSIP/1009-0000000a", "user-callerid,SKIPTTL") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/1009-0000000a", "TOUCH_MONITOR=1542452982.64") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/1009-0000000a", "AMPUSER=1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/1009-0000000a", "13?report") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-user-callerid,s,16)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:16] NoOp("PJSIP/1009-0000000a", "Macro Depth is 3") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("PJSIP/1009-0000000a", "1?report2:macroerror") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("PJSIP/1009-0000000a", "1?continue") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:37] Set("PJSIP/1009-0000000a", "CALLERID(number)=1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:38] Set("PJSIP/1009-0000000a", "CALLERID(name)=Travis Laptop") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("PJSIP/1009-0000000a", "0?cnum") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:40] Set("PJSIP/1009-0000000a", "CDR(cnam)=Travis Laptop") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:41] Set("PJSIP/1009-0000000a", "CDR(cnum)=1009") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-user-callerid:42] Set("PJSIP/1009-0000000a", "CHANNEL(language)=en") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-vm:2] Set("PJSIP/1009-0000000a", "VMGAIN=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-vm:3] Macro("PJSIP/1009-0000000a", "blkvm-check,") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-blkvm-check:1] Set("PJSIP/1009-0000000a", "GOSUB_RETVAL=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf("PJSIP/1009-0000000a", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-blkvm-check:3] MacroExit("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-vm:4] GotoIf("PJSIP/1009-0000000a", "1?vmx,1") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-vm,vmx,1)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:1] Set("PJSIP/1009-0000000a", "MEXTEN=1001") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:2] Set("PJSIP/1009-0000000a", "MMODE=NOANSWER") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:3] Set("PJSIP/1009-0000000a", "RETVM=") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:4] Set("PJSIP/1009-0000000a", "MODE=unavail") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:5] Macro("PJSIP/1009-0000000a", "get-vmcontext,1001") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/1009-0000000a", "VMCONTEXT=default") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/1009-0000000a", "0?200:300") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:6] Set("PJSIP/1009-0000000a", "MODE=unavail") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:7] NoOp("PJSIP/1009-0000000a", "MODE IS: unavail") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:8] GotoIf("PJSIP/1009-0000000a", "1?chknomsg") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-vm,vmx,10)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:10] GotoIf("PJSIP/1009-0000000a", "0?s-NOANSWER,1") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:11] GotoIf("PJSIP/1009-0000000a", "1?notdirect") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-vm,vmx,13)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:13] NoOp("PJSIP/1009-0000000a", "Checking if ext 1001 is enabled: ") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [vmx@macro-vm:14] GotoIf("PJSIP/1009-0000000a", "1?s-NOANSWER,1") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-vm,s-NOANSWER,1)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s-NOANSWER@macro-vm:1] Macro("PJSIP/1009-0000000a", "get-vmcontext,1001") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/1009-0000000a", "VMCONTEXT=default") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/1009-0000000a", "0?200:300") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] pbx.c: Executing [s-NOANSWER@macro-vm:2] VoiceMail("PJSIP/1009-0000000a", "1001@default,u") in new stack
[2018-11-17 11:09:43] VERBOSE[29234][C-0000000c] file.c: <PJSIP/1009-0000000a> Playing '/var/spool/asterisk/voicemail/default/1001/unavail.slin' (language 'en')
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] app_macro.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'PJSIP/1009-0000000a' in macro 'vm'
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] app_macro.c: Spawn extension (macro-exten-vm, s, 33) exited non-zero on 'PJSIP/1009-0000000a' in macro 'exten-vm'
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Spawn extension (ext-local, 1001, 2) exited non-zero on 'PJSIP/1009-0000000a'
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/1009-0000000a", "hangupcall,") in new stack
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/1009-0000000a", "1?theend") in new stack
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/1009-0000000a", "0?Set(CDR(recordingfile)=)") in new stack
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/1009-0000000a", " monior file= ") in new stack
[2018-11-17 11:09:44] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-hangupcall:5] AGI("PJSIP/1009-0000000a", "attendedtransfer-rec-restart.php,,") in new stack
[2018-11-17 11:09:45] VERBOSE[29234][C-0000000c] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-11-17 11:09:45] VERBOSE[29234][C-0000000c] res_agi.c: <PJSIP/1009-0000000a>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-11-17 11:09:45] VERBOSE[29234][C-0000000c] pbx.c: Executing [s@macro-hangupcall:6] Hangup("PJSIP/1009-0000000a", "") in new stack
[2018-11-17 11:09:45] VERBOSE[29234][C-0000000c] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'PJSIP/1009-0000000a' in macro 'hangupcall'
[2018-11-17 11:09:45] VERBOSE[29234][C-0000000c] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/1009-0000000a'

dicko · November 17, 2018, 12:51pm

Try from bash

mv /var/lib/asterisk/astdb.sqlite3 /tmp
cp /tmp/astdb.sqlite3 /var/lib/aaterisk/

travis_farmer · November 17, 2018, 1:05pm

Thanks for responding.

i still get
[2018-11-17 13:03:54] WARNING[13404] db.c: Error executing SQL (COMMIT): database is locked

~Travis

dicko · November 17, 2018, 1:09pm

If a reboot retains the lock, then you should probably dump the database, delete it then import it back , recipes on google.

of course all the above should be done with asterisk stopped.

travis_farmer · November 17, 2018, 1:22pm

If a reboot retains the lock…

the reboot fixed it! thank you very much!

~Travis

system · November 24, 2018, 1:22pm

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.