FreePBX Pastebin

Logs transfer

From Acrotec, 5 Months ago, written in Plain Text, viewed 3 times.
URL https://pastebin.freepbx.org/view/33d5cc92 Embed
Download Paste or View Raw
  1. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(ARG3=dontcare)") in new stack
  2. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@sub-record-check:12] Set("SIP/anonymous.invalid-0000019b", "REC_POLICY_MODE_SAVE=") in new stack
  3. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(REC_STATUS=NO)") in new stack
  4. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/anonymous.invalid-0000019b", "2?checkaction") in new stack
  5. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (sub-record-check,s,17)
  6. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/anonymous.invalid-0000019b", "1?sub-record-check,in,1") in new stack
  7. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (sub-record-check,in,1)
  8. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/anonymous.invalid-0000019b", "Inbound Recording Check to s") in new stack
  9. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [in@sub-record-check:2] Set("SIP/anonymous.invalid-0000019b", "FROMEXTEN=unknown") in new stack
  10. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/anonymous.invalid-0000019b", "9?Set(FROMEXTEN=anonymous)") in new stack
  11. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/anonymous.invalid-0000019b", "recordcheck,1(dontcare,in,s)") in new stack
  12. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/anonymous.invalid-0000019b", "Starting recording check against dontcare") in new stack
  13. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/anonymous.invalid-0000019b", "dontcare") in new stack
  14. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  15. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/anonymous.invalid-0000019b", "") in new stack
  16. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [in@sub-record-check:5] Return("SIP/anonymous.invalid-0000019b", "") in new stack
  17. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:3] Set("SIP/anonymous.invalid-0000019b", "CHANNEL(tonezone)=au") in new stack
  18. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:4] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(__FROM_DID=s)") in new stack
  19. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:5] Set("SIP/anonymous.invalid-0000019b", "returnhere=1") in new stack
  20. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:6] Gosub("SIP/anonymous.invalid-0000019b", "app-blacklist-check,s,1()") in new stack
  21. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/anonymous.invalid-0000019b", "0?blacklisted") in new stack
  22. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/anonymous.invalid-0000019b", "CALLED_BLACKLIST=1") in new stack
  23. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/anonymous.invalid-0000019b", "") in new stack
  24. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:7] Set("SIP/anonymous.invalid-0000019b", "CDR(did)=0295536300") in new stack
  25. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:8] GotoIf("SIP/anonymous.invalid-0000019b", "0?") in new stack
  26. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:9] ExecIf("SIP/anonymous.invalid-0000019b", "0 ?Set(CALLERID(name)=anonymous)") in new stack
  27. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:10] Set("SIP/anonymous.invalid-0000019b", "__MOHCLASS=") in new stack
  28. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:11] Set("SIP/anonymous.invalid-0000019b", "__REVERSAL_REJECT=FALSE") in new stack
  29. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:12] GotoIf("SIP/anonymous.invalid-0000019b", "1?post-reverse-charge") in new stack
  30. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (ext-did,s,14)
  31. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:14] NoOp("SIP/anonymous.invalid-0000019b", "") in new stack
  32. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:15] Set("SIP/anonymous.invalid-0000019b", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  33. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:16] Set("SIP/anonymous.invalid-0000019b", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  34. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:17] Set("SIP/anonymous.invalid-0000019b", "CALLERID(name-pres)=allowed_not_screened") in new stack
  35. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:18] Set("SIP/anonymous.invalid-0000019b", "CALLERID(num-pres)=allowed_not_screened") in new stack
  36. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:19] NoOp("SIP/anonymous.invalid-0000019b", "CallerID Entry Point") in new stack
  37. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:20] Set("SIP/anonymous.invalid-0000019b", "__CRM_DIRECTION=INBOUND") in new stack
  38. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:21] Set("SIP/anonymous.invalid-0000019b", "__CRM_SOURCE=anonymous") in new stack
  39. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:22] Set("SIP/anonymous.invalid-0000019b", "__CRM_LINKEDID=1605216512.894") in new stack
  40. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:23] AGI("SIP/anonymous.invalid-0000019b", "sangomacrm.agi,true") in new stack
  41. [2020-11-12 21:28:32] VERBOSE[19071][C-000001c5] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  42. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] res_agi.c: <SIP/anonymous.invalid-0000019b>AGI Script sangomacrm.agi completed, returning 0
  43. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:24] ExecIf("SIP/anonymous.invalid-0000019b", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  44. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@ext-did:25] Goto("SIP/anonymous.invalid-0000019b", "app-daynight,1,1") in new stack
  45. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (app-daynight,1,1)
  46. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [1@app-daynight:1] GotoIf("SIP/anonymous.invalid-0000019b", "1?ext-local,vmu100,1:ext-group,1000,1") in new stack
  47. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (ext-local,vmu100,1)
  48. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmu100@ext-local:1] Macro("SIP/anonymous.invalid-0000019b", "vm,100,NOANSWER,") in new stack
  49. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-vm:1] Macro("SIP/anonymous.invalid-0000019b", "user-callerid,SKIPTTL") in new stack
  50. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/anonymous.invalid-0000019b", "TOUCH_MONITOR=1605216512.894") in new stack
  51. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/anonymous.invalid-0000019b", "AMPUSER=anonymous") in new stack
  52. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/anonymous.invalid-0000019b", "HOTDESCKCHAN=anonymous.invalid-0000019b") in new stack
  53. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/anonymous.invalid-0000019b", "HOTDESKEXTEN=anonymous.invalid") in new stack
  54. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/anonymous.invalid-0000019b", "HOTDESKCALL=0") in new stack
  55. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(HOTDESKCALL=1)") in new stack
  56. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(CALLERID(name)=)") in new stack
  57. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/anonymous.invalid-0000019b", "0?report") in new stack
  58. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/anonymous.invalid-0000019b", "1?Set(REALCALLERIDNUM=anonymous)") in new stack
  59. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/anonymous.invalid-0000019b", "AMPUSER=") in new stack
  60. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/anonymous.invalid-0000019b", "0?limit") in new stack
  61. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/anonymous.invalid-0000019b", "AMPUSERCIDNAME=") in new stack
  62. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  63. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/anonymous.invalid-0000019b", "1?report") in new stack
  64. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-user-callerid,s,29)
  65. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:29] NoOp("SIP/anonymous.invalid-0000019b", "Macro Depth is 2") in new stack
  66. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("SIP/anonymous.invalid-0000019b", "1?report2:macroerror") in new stack
  67. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-user-callerid,s,31)
  68. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("SIP/anonymous.invalid-0000019b", "1?continue") in new stack
  69. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-user-callerid,s,50)
  70. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:50] Set("SIP/anonymous.invalid-0000019b", "CALLERID(number)=anonymous") in new stack
  71. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:51] Set("SIP/anonymous.invalid-0000019b", "CALLERID(name)=Anonymous") in new stack
  72. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("SIP/anonymous.invalid-0000019b", "0?cnum") in new stack
  73. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:53] Set("SIP/anonymous.invalid-0000019b", "CDR(cnam)=Anonymous") in new stack
  74. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:54] Set("SIP/anonymous.invalid-0000019b", "CDR(cnum)=anonymous") in new stack
  75. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-user-callerid:55] Set("SIP/anonymous.invalid-0000019b", "CHANNEL(language)=en_AU") in new stack
  76. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-vm:2] Set("SIP/anonymous.invalid-0000019b", "VMGAIN=") in new stack
  77. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-vm:3] Macro("SIP/anonymous.invalid-0000019b", "blkvm-check,") in new stack
  78. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-blkvm-check:1] Set("SIP/anonymous.invalid-0000019b", "GOSUB_RETVAL=") in new stack
  79. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
  80. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-blkvm-check:3] MacroExit("SIP/anonymous.invalid-0000019b", "") in new stack
  81. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-vm:4] GotoIf("SIP/anonymous.invalid-0000019b", "1?vmx,1") in new stack
  82. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-vm,vmx,1)
  83. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:1] Set("SIP/anonymous.invalid-0000019b", "__EXTTOCALL=100") in new stack
  84. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:2] Set("SIP/anonymous.invalid-0000019b", "__CRM_VOICEMAIL=100") in new stack
  85. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:3] Set("SIP/anonymous.invalid-0000019b", "MEXTEN=100") in new stack
  86. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:4] Set("SIP/anonymous.invalid-0000019b", "MMODE=NOANSWER") in new stack
  87. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:5] Set("SIP/anonymous.invalid-0000019b", "RETVM=") in new stack
  88. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:6] Set("SIP/anonymous.invalid-0000019b", "MODE=unavail") in new stack
  89. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:7] Macro("SIP/anonymous.invalid-0000019b", "get-vmcontext,100") in new stack
  90. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:1] Set("SIP/anonymous.invalid-0000019b", "VMCONTEXT=default") in new stack
  91. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("SIP/anonymous.invalid-0000019b", "0?200:300") in new stack
  92. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
  93. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("SIP/anonymous.invalid-0000019b", "") in new stack
  94. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:8] Set("SIP/anonymous.invalid-0000019b", "MODE=unavail") in new stack
  95. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:9] NoOp("SIP/anonymous.invalid-0000019b", "MODE IS: unavail") in new stack
  96. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:10] GotoIf("SIP/anonymous.invalid-0000019b", "1?chknomsg") in new stack
  97. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-vm,vmx,12)
  98. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:12] GotoIf("SIP/anonymous.invalid-0000019b", "0?s-NOANSWER,1") in new stack
  99. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:13] GotoIf("SIP/anonymous.invalid-0000019b", "1?notdirect") in new stack
  100. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-vm,vmx,15)
  101. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:15] NoOp("SIP/anonymous.invalid-0000019b", "Checking if ext 100 is enabled: ") in new stack
  102. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [vmx@macro-vm:16] GotoIf("SIP/anonymous.invalid-0000019b", "1?s-NOANSWER,1") in new stack
  103. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-vm,s-NOANSWER,1)
  104. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s-NOANSWER@macro-vm:1] Macro("SIP/anonymous.invalid-0000019b", "get-vmcontext,100") in new stack
  105. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:1] Set("SIP/anonymous.invalid-0000019b", "VMCONTEXT=default") in new stack
  106. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("SIP/anonymous.invalid-0000019b", "0?200:300") in new stack
  107. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
  108. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("SIP/anonymous.invalid-0000019b", "") in new stack
  109. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s-NOANSWER@macro-vm:2] VoiceMail("SIP/anonymous.invalid-0000019b", "100@default,u") in new stack
  110. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] file.c: <SIP/anonymous.invalid-0000019b> Playing '/var/spool/asterisk/voicemail/default/100/unavail.slin' (language 'en_AU')
  111. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] file.c: <SIP/anonymous.invalid-0000019b> Playing 'vm-intro.ulaw' (language 'en_AU')
  112. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] app_macro.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'SIP/anonymous.invalid-0000019b' in macro 'vm'
  113. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Spawn extension (ext-local, vmu100, 1) exited non-zero on 'SIP/anonymous.invalid-0000019b'
  114. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [h@ext-local:1] Macro("SIP/anonymous.invalid-0000019b", "hangupcall,") in new stack
  115. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/anonymous.invalid-0000019b", "1?theend") in new stack
  116. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  117. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/anonymous.invalid-0000019b", "0?Set(CDR(recordingfile)=)") in new stack
  118. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/anonymous.invalid-0000019b", " montior file= ") in new stack
  119. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/anonymous.invalid-0000019b", "1?skipagi") in new stack
  120. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx_builtins.c: Goto (macro-hangupcall,s,7)
  121. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/anonymous.invalid-0000019b", "") in new stack
  122. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/anonymous.invalid-0000019b' in macro 'hangupcall'
  123. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/anonymous.invalid-0000019b'
  124. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] app_stack.c: SIP/anonymous.invalid-0000019b Internal Gosub(crm-hangup,s,1) start
  125. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/anonymous.invalid-0000019b", "Sending Hangup to CRM") in new stack
  126. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/anonymous.invalid-0000019b", "HANGUP CAUSE: 16") in new stack
  127. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/anonymous.invalid-0000019b", "1?Set(__CRM_VOICEMAIL=FAILED)") in new stack
  128. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/anonymous.invalid-0000019b", "MASTER CHANNEL: 1605216512.894 = 1605216512.894") in new stack
  129. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/anonymous.invalid-0000019b", "0?return") in new stack
  130. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:6] Set("SIP/anonymous.invalid-0000019b", "__CRM_HANGUP=1") in new stack
  131. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/anonymous.invalid-0000019b", "sangomacrm.agi") in new stack
  132. [2020-11-12 21:28:33] VERBOSE[19071][C-000001c5] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  133. [2020-11-12 21:28:34] VERBOSE[19071][C-000001c5] res_agi.c: <SIP/anonymous.invalid-0000019b>AGI Script sangomacrm.agi completed, returning 0
  134. [2020-11-12 21:28:34] VERBOSE[19071][C-000001c5] pbx.c: Executing [s@crm-hangup:8] Return("SIP/anonymous.invalid-0000019b", "") in new stack
  135. [2020-11-12 21:28:34] VERBOSE[19071][C-000001c5] app_stack.c: Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/anonymous.invalid-0000019b'
  136. [2020-11-12 21:28:34] VERBOSE[19071][C-000001c5] app_stack.c: SIP/anonymous.invalid-0000019b Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  137. [2020-11-12 21:28:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  138. [2020-11-12 21:28:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  139. [2020-11-12 21:28:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  140. [2020-11-12 21:28:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  141. [2020-11-12 21:28:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  142. [2020-11-12 21:30:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  143. [2020-11-12 21:30:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  144. [2020-11-12 21:30:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  145. [2020-11-12 21:30:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  146. [2020-11-12 21:30:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  147. [2020-11-12 21:32:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  148. [2020-11-12 21:32:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  149. [2020-11-12 21:32:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  150. [2020-11-12 21:32:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  151. [2020-11-12 21:32:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  152. [2020-11-12 21:34:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  153. [2020-11-12 21:34:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  154. [2020-11-12 21:34:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  155. [2020-11-12 21:34:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  156. [2020-11-12 21:34:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  157. [2020-11-12 21:36:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  158. [2020-11-12 21:36:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  159. [2020-11-12 21:36:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  160. [2020-11-12 21:36:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  161. [2020-11-12 21:36:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  162. [2020-11-12 21:38:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  163. [2020-11-12 21:38:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  164. [2020-11-12 21:38:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  165. [2020-11-12 21:38:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  166. [2020-11-12 21:38:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  167. [2020-11-12 21:40:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  168. [2020-11-12 21:40:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  169. [2020-11-12 21:40:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  170. [2020-11-12 21:40:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  171. [2020-11-12 21:40:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  172. [2020-11-12 21:40:55] VERBOSE[19480] pbx_variables.c: Setting global variable 'SIPDOMAIN' to 'pabx.voip.mpknetwork.net'
  173. [2020-11-12 21:40:55] VERBOSE[19480] netsock2.c: Using SIP RTP Audio TOS bits 184
  174. [2020-11-12 21:40:55] VERBOSE[19480] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  175. [2020-11-12 21:40:55] VERBOSE[19480] netsock2.c: Using SIP RTP Audio CoS mark 5
  176. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:1] Macro("PJSIP/100-000001a7", "user-callerid,") in new stack
  177. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/100-000001a7", "TOUCH_MONITOR=1605217255.895") in new stack
  178. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/100-000001a7", "AMPUSER=100") in new stack
  179. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/100-000001a7", "HOTDESCKCHAN=100-000001a7") in new stack
  180. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/100-000001a7", "HOTDESKEXTEN=100") in new stack
  181. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/100-000001a7", "HOTDESKCALL=0") in new stack
  182. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("PJSIP/100-000001a7", "0?Set(HOTDESKCALL=1)") in new stack
  183. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("PJSIP/100-000001a7", "0?Set(CALLERID(name)=)") in new stack
  184. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/100-000001a7", "0?report") in new stack
  185. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("PJSIP/100-000001a7", "1?Set(REALCALLERIDNUM=100)") in new stack
  186. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/100-000001a7", "AMPUSER=100") in new stack
  187. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("PJSIP/100-000001a7", "0?limit") in new stack
  188. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/100-000001a7", "AMPUSERCIDNAME=Reception R") in new stack
  189. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/100-000001a7", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  190. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/100-000001a7", "0?report") in new stack
  191. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/100-000001a7", "AMPUSERCID=100") in new stack
  192. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:16] Set("PJSIP/100-000001a7", "__DIAL_OPTIONS=HhTtr") in new stack
  193. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/100-000001a7", "CALLERID(all)="Reception R" <100>") in new stack
  194. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:18] Set("PJSIP/100-000001a7", "HOTDESCKCHAN=100-000001a7") in new stack
  195. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:19] Set("PJSIP/100-000001a7", "HOTDESKEXTEN=100") in new stack
  196. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/100-000001a7", "HOTDESKCALL=0") in new stack
  197. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("PJSIP/100-000001a7", "0?Set(HOTDESKCALL=1)") in new stack
  198. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("PJSIP/100-000001a7", "0?Set(CALLERID(name)=)") in new stack
  199. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/100-000001a7", "0?Set(CALLERID(all)="" < >)") in new stack
  200. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/100-000001a7", "0?Set(CUSDIAL=)") in new stack
  201. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("PJSIP/100-000001a7", "0?Set(CALLERID(all)="Reception R" <100>)") in new stack
  202. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:26] GotoIf("PJSIP/100-000001a7", "0?limit") in new stack
  203. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/100-000001a7", "0?Set(GROUP(concurrency_limit)=100)") in new stack
  204. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:28] ExecIf("PJSIP/100-000001a7", "0?Set(CHANNEL(language)=)") in new stack
  205. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/100-000001a7", "Macro Depth is 1") in new stack
  206. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/100-000001a7", "1?report2:macroerror") in new stack
  207. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx_builtins.c: Goto (macro-user-callerid,s,31)
  208. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/100-000001a7", "0?continue") in new stack
  209. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("PJSIP/100-000001a7", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  210. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/100-000001a7", "__TTL=64") in new stack
  211. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("PJSIP/100-000001a7", "1?continue") in new stack
  212. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx_builtins.c: Goto (macro-user-callerid,s,50)
  213. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/100-000001a7", "CALLERID(number)=100") in new stack
  214. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/100-000001a7", "CALLERID(name)=Reception R") in new stack
  215. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/100-000001a7", "0?cnum") in new stack
  216. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/100-000001a7", "CDR(cnam)=Reception R") in new stack
  217. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/100-000001a7", "CDR(cnum)=100") in new stack
  218. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/100-000001a7", "CHANNEL(language)=en_AU") in new stack
  219. [2020-11-12 21:40:55] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:2] Answer("PJSIP/100-000001a7", "") in new stack
  220. [2020-11-12 21:40:56] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:3] Wait("PJSIP/100-000001a7", "1") in new stack
  221. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:4] Set("PJSIP/100-000001a7", "INDEXES=1") in new stack
  222. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:5] Set("PJSIP/100-000001a7", "DAYREC=beep&silence/1&featurecode&digits/1&de-activated") in new stack
  223. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:6] Set("PJSIP/100-000001a7", "NIGHTREC=beep&silence/1&featurecode&digits/1&activated") in new stack
  224. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [*281@from-internal:7] Goto("PJSIP/100-000001a7", "app-daynight-toggle,s,1") in new stack
  225. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx_builtins.c: Goto (app-daynight-toggle,s,1)
  226. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:1] Set("PJSIP/100-000001a7", "LOOPCNT=1") in new stack
  227. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:2] Set("PJSIP/100-000001a7", "ITER=1") in new stack
  228. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:3] Set("PJSIP/100-000001a7", "INDEX=1") in new stack
  229. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:4] Set("PJSIP/100-000001a7", "MODE=NIGHT") in new stack
  230. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:5] GotoIf("PJSIP/100-000001a7", "0?end1") in new stack
  231. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:6] Set("PJSIP/100-000001a7", "DAYNIGHTMODE=NIGHT") in new stack
  232. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:7] Set("PJSIP/100-000001a7", "ITER=2") in new stack
  233. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:8] GotoIf("PJSIP/100-000001a7", "0?begin1") in new stack
  234. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:9] Set("PJSIP/100-000001a7", "LOOPCNT=1") in new stack
  235. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:10] Set("PJSIP/100-000001a7", "ITER=1") in new stack
  236. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:11] Set("PJSIP/100-000001a7", "INDEX=1") in new stack
  237. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:12] GotoIf("PJSIP/100-000001a7", "1?day:night") in new stack
  238. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx_builtins.c: Goto (app-daynight-toggle,s,13)
  239. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:13] Set("PJSIP/100-000001a7", "DB(DAYNIGHT/C1)=DAY") in new stack
  240. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:14] Set("PJSIP/100-000001a7", "DEVICE_STATE(Custom:DAYNIGHT1)=NOT_INUSE") in new stack
  241. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:15] Goto("PJSIP/100-000001a7", "end2") in new stack
  242. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx_builtins.c: Goto (app-daynight-toggle,s,19)
  243. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:19] Set("PJSIP/100-000001a7", "ITER=2") in new stack
  244. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:20] GotoIf("PJSIP/100-000001a7", "0?begin2") in new stack
  245. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:21] ExecIf("PJSIP/100-000001a7", "1?Playback(beep&silence/1&featurecode&digits/1&de-activated):Playback(beep&silence/1&featurecode&digits/1&activated)") in new stack
  246. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] file.c: <PJSIP/100-000001a7> Playing 'beep.ulaw' (language 'en_AU')
  247. [2020-11-12 21:40:57] VERBOSE[10503][C-000001c6] file.c: <PJSIP/100-000001a7> Playing 'silence/1.ulaw' (language 'en_AU')
  248. [2020-11-12 21:40:58] VERBOSE[10503][C-000001c6] file.c: <PJSIP/100-000001a7> Playing 'featurecode.ulaw' (language 'en_AU')
  249. [2020-11-12 21:40:59] VERBOSE[10503][C-000001c6] file.c: <PJSIP/100-000001a7> Playing 'digits/1.ulaw' (language 'en_AU')
  250. [2020-11-12 21:41:00] VERBOSE[10503][C-000001c6] file.c: <PJSIP/100-000001a7> Playing 'de-activated.alaw' (language 'en_AU')
  251. [2020-11-12 21:41:01] VERBOSE[10503][C-000001c6] pbx.c: Executing [s@app-daynight-toggle:22] Hangup("PJSIP/100-000001a7", "") in new stack
  252. [2020-11-12 21:41:01] VERBOSE[10503][C-000001c6] pbx.c: Spawn extension (app-daynight-toggle, s, 22) exited non-zero on 'PJSIP/100-000001a7'
  253. [2020-11-12 21:42:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  254. [2020-11-12 21:42:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  255. [2020-11-12 21:42:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  256. [2020-11-12 21:42:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  257. [2020-11-12 21:42:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  258. [2020-11-12 21:44:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  259. [2020-11-12 21:44:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  260. [2020-11-12 21:44:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  261. [2020-11-12 21:44:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  262. [2020-11-12 21:44:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  263. [2020-11-12 21:46:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  264. [2020-11-12 21:46:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  265. [2020-11-12 21:46:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  266. [2020-11-12 21:46:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  267. [2020-11-12 21:46:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  268. [2020-11-12 21:48:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  269. [2020-11-12 21:48:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  270. [2020-11-12 21:48:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  271. [2020-11-12 21:48:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  272. [2020-11-12 21:48:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  273. [2020-11-12 21:50:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  274. [2020-11-12 21:50:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  275. [2020-11-12 21:50:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  276. [2020-11-12 21:50:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  277. [2020-11-12 21:50:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  278. [2020-11-12 21:52:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  279. [2020-11-12 21:52:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  280. [2020-11-12 21:52:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  281. [2020-11-12 21:52:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  282. [2020-11-12 21:52:46] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  283. [2020-11-12 21:54:28] VERBOSE[1714] pbx_variables.c: Setting global variable 'SIPDOMAIN' to 'pabx.voip.mpknetwork.net'
  284. [2020-11-12 21:54:28] VERBOSE[1714] netsock2.c: Using SIP RTP Audio TOS bits 184
  285. [2020-11-12 21:54:28] VERBOSE[1714] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  286. [2020-11-12 21:54:28] VERBOSE[1714] netsock2.c: Using SIP RTP Audio CoS mark 5
  287. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:1] Macro("PJSIP/111-000001a8", "user-callerid,LIMIT,EXTERNAL,") in new stack
  288. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/111-000001a8", "TOUCH_MONITOR=1605218068.896") in new stack
  289. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/111-000001a8", "AMPUSER=111") in new stack
  290. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/111-000001a8", "HOTDESCKCHAN=111-000001a8") in new stack
  291. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/111-000001a8", "HOTDESKEXTEN=111") in new stack
  292. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/111-000001a8", "HOTDESKCALL=0") in new stack
  293. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("PJSIP/111-000001a8", "0?Set(HOTDESKCALL=1)") in new stack
  294. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(name)=)") in new stack
  295. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/111-000001a8", "0?report") in new stack
  296. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("PJSIP/111-000001a8", "1?Set(REALCALLERIDNUM=111)") in new stack
  297. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/111-000001a8", "AMPUSER=111") in new stack
  298. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("PJSIP/111-000001a8", "0?limit") in new stack
  299. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/111-000001a8", "AMPUSERCIDNAME=Don") in new stack
  300. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/111-000001a8", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  301. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/111-000001a8", "0?report") in new stack
  302. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/111-000001a8", "AMPUSERCID=111") in new stack
  303. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:16] Set("PJSIP/111-000001a8", "__DIAL_OPTIONS=HhTtr") in new stack
  304. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/111-000001a8", "CALLERID(all)="Don" <111>") in new stack
  305. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:18] Set("PJSIP/111-000001a8", "HOTDESCKCHAN=111-000001a8") in new stack
  306. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:19] Set("PJSIP/111-000001a8", "HOTDESKEXTEN=111") in new stack
  307. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/111-000001a8", "HOTDESKCALL=0") in new stack
  308. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("PJSIP/111-000001a8", "0?Set(HOTDESKCALL=1)") in new stack
  309. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(name)=)") in new stack
  310. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(all)="" < >)") in new stack
  311. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/111-000001a8", "0?Set(CUSDIAL=)") in new stack
  312. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(all)="Don" <111>)") in new stack
  313. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:26] GotoIf("PJSIP/111-000001a8", "0?limit") in new stack
  314. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/111-000001a8", "1?Set(GROUP(concurrency_limit)=111)") in new stack
  315. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:28] ExecIf("PJSIP/111-000001a8", "0?Set(CHANNEL(language)=)") in new stack
  316. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/111-000001a8", "Macro Depth is 1") in new stack
  317. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/111-000001a8", "1?report2:macroerror") in new stack
  318. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-user-callerid,s,31)
  319. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/111-000001a8", "1?continue") in new stack
  320. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-user-callerid,s,50)
  321. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/111-000001a8", "CALLERID(number)=111") in new stack
  322. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/111-000001a8", "CALLERID(name)=Don") in new stack
  323. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/111-000001a8", "0?cnum") in new stack
  324. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/111-000001a8", "CDR(cnam)=Don") in new stack
  325. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/111-000001a8", "CDR(cnum)=111") in new stack
  326. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/111-000001a8", "CHANNEL(language)=en_AU") in new stack
  327. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:2] Gosub("PJSIP/111-000001a8", "sub-record-check,s,1(out,0424755678,dontcare)") in new stack
  328. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/111-000001a8", "0?initialized") in new stack
  329. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/111-000001a8", "__REC_STATUS=INITIALIZED") in new stack
  330. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/111-000001a8", "NOW=1605218068") in new stack
  331. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/111-000001a8", "__DAY=12") in new stack
  332. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/111-000001a8", "__MONTH=11") in new stack
  333. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/111-000001a8", "__YEAR=2020") in new stack
  334. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/111-000001a8", "__TIMESTR=20201112-215428") in new stack
  335. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/111-000001a8", "__FROMEXTEN=111") in new stack
  336. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/111-000001a8", "__MON_FMT=wav") in new stack
  337. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/111-000001a8", "Recordings initialized") in new stack
  338. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/111-000001a8", "0?Set(ARG3=dontcare)") in new stack
  339. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/111-000001a8", "REC_POLICY_MODE_SAVE=") in new stack
  340. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/111-000001a8", "0?Set(REC_STATUS=NO)") in new stack
  341. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/111-000001a8", "3?checkaction") in new stack
  342. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (sub-record-check,s,17)
  343. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/111-000001a8", "1?sub-record-check,out,1") in new stack
  344. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (sub-record-check,out,1)
  345. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [out@sub-record-check:1] NoOp("PJSIP/111-000001a8", "Outbound Recording Check from 111 to 0424755678") in new stack
  346. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [out@sub-record-check:2] Set("PJSIP/111-000001a8", "RECMODE=dontcare") in new stack
  347. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [out@sub-record-check:3] ExecIf("PJSIP/111-000001a8", "1?Goto(routewins)") in new stack
  348. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (sub-record-check,out,7)
  349. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [out@sub-record-check:7] Gosub("PJSIP/111-000001a8", "recordcheck,1(dontcare,out,0424755678)") in new stack
  350. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/111-000001a8", "Starting recording check against dontcare") in new stack
  351. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/111-000001a8", "dontcare") in new stack
  352. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  353. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/111-000001a8", "") in new stack
  354. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [out@sub-record-check:8] Return("PJSIP/111-000001a8", "") in new stack
  355. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:3] ExecIf("PJSIP/111-000001a8", "0 ?Set(CDR(accountcode)=)") in new stack
  356. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:4] Set("PJSIP/111-000001a8", "_ROUTEID=1") in new stack
  357. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:5] Set("PJSIP/111-000001a8", "_ROUTENAME=General") in new stack
  358. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:6] Set("PJSIP/111-000001a8", "MOHCLASS=default") in new stack
  359. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:7] ExecIf("PJSIP/111-000001a8", "1?Set(TRUNKCIDOVERRIDE=0295536300)") in new stack
  360. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:8] Set("PJSIP/111-000001a8", "_CALLERIDNAMEINTERNAL=Don") in new stack
  361. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:9] Set("PJSIP/111-000001a8", "_CALLERIDNUMINTERNAL=111") in new stack
  362. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:10] Set("PJSIP/111-000001a8", "_EMAILNOTIFICATION=FALSE") in new stack
  363. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:11] Set("PJSIP/111-000001a8", "_NODEST=") in new stack
  364. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [0424755678@from-internal:12] Macro("PJSIP/111-000001a8", "dialout-trunk,1,0424755678,,off") in new stack
  365. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:1] Set("PJSIP/111-000001a8", "DIAL_TRUNK=1") in new stack
  366. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("PJSIP/111-000001a8", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack
  367. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("PJSIP/111-000001a8", "0?sub-pincheck,s,1()") in new stack
  368. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(num)=111)") in new stack
  369. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("PJSIP/111-000001a8", "0?disabletrunk,1") in new stack
  370. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:6] Set("PJSIP/111-000001a8", "DIAL_NUMBER=0424755678") in new stack
  371. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:7] Set("PJSIP/111-000001a8", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack
  372. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:8] Set("PJSIP/111-000001a8", "OUTBOUND_GROUP=OUT_1") in new stack
  373. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:9] Set("PJSIP/111-000001a8", "DIAL_TRUNK_OPTIONS=T") in new stack
  374. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("PJSIP/111-000001a8", "1?nomax") in new stack
  375. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
  376. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/111-000001a8", "0?skipoutcid") in new stack
  377. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("PJSIP/111-000001a8", "outbound-callerid,1") in new stack
  378. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/111-000001a8", "111") in new stack
  379. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/111-000001a8", "") in new stack
  380. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/111-000001a8", "off") in new stack
  381. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(name-pres)=)") in new stack
  382. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(num-pres)=)") in new stack
  383. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:6] Set("PJSIP/111-000001a8", "HOTDESCKCHAN=111-000001a8") in new stack
  384. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:7] Set("PJSIP/111-000001a8", "HOTDESKEXTEN=111") in new stack
  385. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:8] Set("PJSIP/111-000001a8", "HOTDESKCALL=0") in new stack
  386. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("PJSIP/111-000001a8", "0?Set(HOTDESKCALL=1)") in new stack
  387. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(name)=)") in new stack
  388. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:11] Set("PJSIP/111-000001a8", "ALLOWTHISROUTE=NO") in new stack
  389. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("PJSIP/111-000001a8", "0?Set(ALLOWTHISROUTE=YES)") in new stack
  390. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("PJSIP/111-000001a8", "0?Hangup()") in new stack
  391. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("PJSIP/111-000001a8", "0?Set(REALCALLERIDNUM=111)") in new stack
  392. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/111-000001a8", "0?Set(AMPUSER=111)") in new stack
  393. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("PJSIP/111-000001a8", "1?normcid") in new stack
  394. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
  395. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:20] Set("PJSIP/111-000001a8", "USEROUTCID=") in new stack
  396. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:21] Set("PJSIP/111-000001a8", "EMERGENCYCID=") in new stack
  397. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/111-000001a8", "0?Set(EMERGENCYCID=)") in new stack
  398. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:23] Set("PJSIP/111-000001a8", "TRUNKOUTCID=0295536300") in new stack
  399. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("PJSIP/111-000001a8", "1?trunkcid") in new stack
  400. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
  401. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("PJSIP/111-000001a8", "1?Set(CALLERID(all)=0295536300)") in new stack
  402. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(all)=)") in new stack
  403. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("PJSIP/111-000001a8", "1?Set(CALLERID(all)=0295536300)") in new stack
  404. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERID(all)=111)") in new stack
  405. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:34] Set("PJSIP/111-000001a8", "TIOHIDE=no") in new stack
  406. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:35] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
  407. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
  408. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
  409. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("PJSIP/111-000001a8", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
  410. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:39] Set("PJSIP/111-000001a8", "CDR(outbound_cnum)=0295536300") in new stack
  411. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-outbound-callerid:40] Set("PJSIP/111-000001a8", "CDR(outbound_cnam)=") in new stack
  412. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("PJSIP/111-000001a8", "0?sub-flp-1,s,1()") in new stack
  413. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:15] Set("PJSIP/111-000001a8", "OUTNUM=0424755678") in new stack
  414. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:16] Set("PJSIP/111-000001a8", "custom=SIP/COM2") in new stack
  415. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("PJSIP/111-000001a8", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
  416. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/111-000001a8", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
  417. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("PJSIP/111-000001a8", "dialout-trunk-predial-hook,") in new stack
  418. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/111-000001a8", "") in new stack
  419. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("PJSIP/111-000001a8", "0?skipcrm") in new stack
  420. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:21] Set("PJSIP/111-000001a8", "__CRM_DIRECTION=OUTBOUND") in new stack
  421. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:22] Set("PJSIP/111-000001a8", "__CRM_DESTINATION=0424755678") in new stack
  422. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:23] Set("PJSIP/111-000001a8", "__CRM_SOURCE=111") in new stack
  423. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("PJSIP/111-000001a8", "sangomacrm.agi") in new stack
  424. [2020-11-12 21:54:28] VERBOSE[4395][C-000001c7] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  425. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] res_agi.c: <PJSIP/111-000001a8>AGI Script sangomacrm.agi completed, returning 0
  426. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:25] Set("PJSIP/111-000001a8", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack
  427. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("PJSIP/111-000001a8", "CRM Finished") in new stack
  428. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("PJSIP/111-000001a8", "0?bypass,1") in new stack
  429. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("PJSIP/111-000001a8", "1?Set(CONNECTEDLINE(num,i)=0424755678)") in new stack
  430. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("PJSIP/111-000001a8", "1?Set(CONNECTEDLINE(name,i)=CID:0295536300)") in new stack
  431. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("PJSIP/111-000001a8", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)0295536300)") in new stack
  432. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("PJSIP/111-000001a8", "0?customtrunk") in new stack
  433. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("PJSIP/111-000001a8", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack
  434. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:33] Set("PJSIP/111-000001a8", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
  435. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("PJSIP/111-000001a8", "SIP/COM2/0424755678,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^0424755678^0424755678^1^1605218068^^0295536300)") in new stack
  436. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] netsock2.c: Using SIP RTP TOS bits 184
  437. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] netsock2.c: Using SIP RTP CoS mark 5
  438. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] app_stack.c: SIP/COM2-0000019c Internal Gosub(func-apply-sipheaders,s,1(1)) start
  439. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/COM2-0000019c", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  440. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/COM2-0000019c", "Applying SIP Headers to channel SIP/COM2-0000019c") in new stack
  441. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/COM2-0000019c", "TECH=SIP") in new stack
  442. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/COM2-0000019c", "SIPHEADERKEYS=Alert-Info") in new stack
  443. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/COM2-0000019c", "1") in new stack
  444. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/COM2-0000019c", "sipheader=unset") in new stack
  445. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("SIP/COM2-0000019c", "1?SIPRemoveHeader(Alert-Info:)") in new stack
  446. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("SIP/COM2-0000019c", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
  447. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/COM2-0000019c", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
  448. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/COM2-0000019c", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
  449. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/COM2-0000019c", "0?SIPAddHeader(Alert-Info:unset)") in new stack
  450. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("SIP/COM2-0000019c", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
  451. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("SIP/COM2-0000019c", "") in new stack
  452. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/COM2-0000019c", "0") in new stack
  453. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@func-apply-sipheaders:14] Return("SIP/COM2-0000019c", "") in new stack
  454. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] app_stack.c: Spawn extension (from-trunk, 0424755678, 1) exited non-zero on 'SIP/COM2-0000019c'
  455. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] app_stack.c: SIP/COM2-0000019c Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
  456. [2020-11-12 21:54:29] VERBOSE[4395][C-000001c7] app_dial.c: Called SIP/COM2/0424755678
  457. [2020-11-12 21:54:31] VERBOSE[4395][C-000001c7] app_dial.c: SIP/COM2-0000019c is ringing
  458. [2020-11-12 21:54:31] VERBOSE[4395][C-000001c7] app_dial.c: SIP/COM2-0000019c is making progress passing it to PJSIP/111-000001a8
  459. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] app_macro.c: Spawn extension (macro-dialout-trunk, s, 34) exited non-zero on 'PJSIP/111-000001a8' in macro 'dialout-trunk'
  460. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Spawn extension (from-internal, 0424755678, 12) exited non-zero on 'PJSIP/111-000001a8'
  461. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [h@from-internal:1] Macro("PJSIP/111-000001a8", "hangupcall") in new stack
  462. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/111-000001a8", "1?theend") in new stack
  463. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  464. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/111-000001a8", "0?Set(CDR(recordingfile)=)") in new stack
  465. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/111-000001a8", "SIP/COM2-0000019c montior file= ") in new stack
  466. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/111-000001a8", "1?skipagi") in new stack
  467. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx_builtins.c: Goto (macro-hangupcall,s,7)
  468. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/111-000001a8", "") in new stack
  469. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/111-000001a8' in macro 'hangupcall'
  470. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/111-000001a8'
  471. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] app_stack.c: PJSIP/111-000001a8 Internal Gosub(crm-hangup,s,1) start
  472. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/111-000001a8", "Sending Hangup to CRM") in new stack
  473. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/111-000001a8", "HANGUP CAUSE: 127") in new stack
  474. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/111-000001a8", "0?Set(__CRM_VOICEMAIL=)") in new stack
  475. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/111-000001a8", "MASTER CHANNEL: 1605218068.896 = 1605218068.896") in new stack
  476. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/111-000001a8", "0?return") in new stack
  477. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/111-000001a8", "__CRM_HANGUP=1") in new stack
  478. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/111-000001a8", "sangomacrm.agi") in new stack
  479. [2020-11-12 21:54:40] VERBOSE[4395][C-000001c7] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  480. [2020-11-12 21:54:41] VERBOSE[4395][C-000001c7] res_agi.c: <PJSIP/111-000001a8>AGI Script sangomacrm.agi completed, returning 0
  481. [2020-11-12 21:54:41] VERBOSE[4395][C-000001c7] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/111-000001a8", "") in new stack
  482. [2020-11-12 21:54:41] VERBOSE[4395][C-000001c7] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/111-000001a8'
  483. [2020-11-12 21:54:41] VERBOSE[4395][C-000001c7] app_stack.c: PJSIP/111-000001a8 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  484. [2020-11-12 21:54:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  485. [2020-11-12 21:54:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  486. [2020-11-12 21:54:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  487. [2020-11-12 21:54:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  488. [2020-11-12 21:54:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  489. [2020-11-12 21:56:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  490. [2020-11-12 21:56:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  491. [2020-11-12 21:56:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  492. [2020-11-12 21:56:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  493. [2020-11-12 21:56:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  494. [2020-11-12 21:58:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  495. [2020-11-12 21:58:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  496. [2020-11-12 21:58:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  497. [2020-11-12 21:58:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  498. [2020-11-12 21:58:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  499. [2020-11-12 22:00:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  500. [2020-11-12 22:00:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  501. [2020-11-12 22:00:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  502. [2020-11-12 22:00:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  503. [2020-11-12 22:00:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  504. [2020-11-12 22:02:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  505. [2020-11-12 22:02:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  506. [2020-11-12 22:02:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  507. [2020-11-12 22:02:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  508. [2020-11-12 22:02:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  509. [2020-11-12 22:04:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  510. [2020-11-12 22:04:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  511. [2020-11-12 22:04:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  512. [2020-11-12 22:04:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  513. [2020-11-12 22:04:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  514. [2020-11-12 22:06:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  515. [2020-11-12 22:06:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  516. [2020-11-12 22:06:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  517. [2020-11-12 22:06:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  518. [2020-11-12 22:06:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  519. [2020-11-12 22:08:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  520. [2020-11-12 22:08:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  521. [2020-11-12 22:08:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  522. [2020-11-12 22:08:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  523. [2020-11-12 22:08:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  524. [2020-11-12 22:10:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  525. [2020-11-12 22:10:45] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  526. [2020-11-12 22:10:45] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  527. [2020-11-12 22:10:45] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  528. [2020-11-12 22:10:45] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  529. [2020-11-12 22:12:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  530. [2020-11-12 22:12:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  531. [2020-11-12 22:12:45] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  532. [2020-11-12 22:12:45] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  533. [2020-11-12 22:12:45] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  534. [2020-11-12 22:14:45] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
  535. [2020-11-12 22:14:46] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
  536. [2020-11-12 22:14:46] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
  537. [2020-11-12 22:14:46] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
  538. [2020-11-12 22:14:46] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
  539. [2020-11-12 22:14:56] VERBOSE[11826][C-000001c8] netsock2.c: Using SIP RTP TOS bits 184
  540. [2020-11-12 22:14:56] VERBOSE[11826][C-000001c8] netsock2.c: Using SIP RTP CoS mark 5
  541. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-sip-external:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Received incoming SIP connection from unknown peer to 0295536300") in new stack
  542. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "DID=0295536300") in new stack
  543. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-sip-external:3] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "s,1") in new stack
  544. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (from-sip-external,s,1)
  545. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@from-sip-external:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?setlanguage:checkanon") in new stack
  546. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (from-sip-external,s,2)
  547. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CHANNEL(language)=en_AU") in new stack
  548. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@from-sip-external:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?noanonymous") in new stack
  549. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@from-sip-external:4] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "from-trunk,0295536300,1") in new stack
  550. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (from-trunk,0295536300,1)
  551. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-trunk:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Catch-All DID Match - Found 0295536300 - You probably want a DID for this.") in new stack
  552. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-trunk:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__FROM_DID=0295536300") in new stack
  553. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [0295536300@from-trunk:3] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "ext-did,s,1") in new stack
  554. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (ext-did,s,1)
  555. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:1] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__DIRECTION=INBOUND") in new stack
  556. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:2] Gosub("SIP/siptrunk.vpbx.net.au-0000019d", "sub-record-check,s,1(in,s,dontcare)") in new stack
  557. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?initialized") in new stack
  558. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__REC_STATUS=INITIALIZED") in new stack
  559. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:3] Set("SIP/siptrunk.vpbx.net.au-0000019d", "NOW=1605219296") in new stack
  560. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:4] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__DAY=12") in new stack
  561. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:5] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__MONTH=11") in new stack
  562. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:6] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__YEAR=2020") in new stack
  563. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:7] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__TIMESTR=20201112-221456") in new stack
  564. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:8] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__FROMEXTEN=unknown") in new stack
  565. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:9] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__MON_FMT=wav") in new stack
  566. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Recordings initialized") in new stack
  567. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ARG3=dontcare)") in new stack
  568. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000019d", "REC_POLICY_MODE_SAVE=") in new stack
  569. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(REC_STATUS=NO)") in new stack
  570. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "2?checkaction") in new stack
  571. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,s,17)
  572. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?sub-record-check,in,1") in new stack
  573. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,in,1)
  574. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Inbound Recording Check to s") in new stack
  575. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [in@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "FROMEXTEN=unknown") in new stack
  576. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "10?Set(FROMEXTEN=0280603137)") in new stack
  577. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/siptrunk.vpbx.net.au-0000019d", "recordcheck,1(dontcare,in,s)") in new stack
  578. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Starting recording check against dontcare") in new stack
  579. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "dontcare") in new stack
  580. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  581. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  582. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [in@sub-record-check:5] Return("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  583. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:3] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CHANNEL(tonezone)=au") in new stack
  584. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(__FROM_DID=s)") in new stack
  585. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:5] Set("SIP/siptrunk.vpbx.net.au-0000019d", "returnhere=1") in new stack
  586. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:6] Gosub("SIP/siptrunk.vpbx.net.au-0000019d", "app-blacklist-check,s,1()") in new stack
  587. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?blacklisted") in new stack
  588. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CALLED_BLACKLIST=1") in new stack
  589. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  590. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:7] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CDR(did)=0295536300") in new stack
  591. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?") in new stack
  592. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "1 ?Set(CALLERID(name)=0280603137)") in new stack
  593. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:10] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__MOHCLASS=") in new stack
  594. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:11] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__REVERSAL_REJECT=FALSE") in new stack
  595. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:12] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?post-reverse-charge") in new stack
  596. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (ext-did,s,14)
  597. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:14] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  598. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:15] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  599. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:16] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  600. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:17] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CALLERID(name-pres)=allowed_not_screened") in new stack
  601. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:18] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CALLERID(num-pres)=allowed_not_screened") in new stack
  602. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:19] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "CallerID Entry Point") in new stack
  603. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:20] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CRM_DIRECTION=INBOUND") in new stack
  604. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:21] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CRM_SOURCE=0280603137") in new stack
  605. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:22] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CRM_LINKEDID=1605219296.898") in new stack
  606. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:23] AGI("SIP/siptrunk.vpbx.net.au-0000019d", "sangomacrm.agi,true") in new stack
  607. [2020-11-12 22:14:56] VERBOSE[11841][C-000001c8] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  608. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000019d>AGI Script sangomacrm.agi completed, returning 0
  609. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:24] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  610. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@ext-did:25] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "app-daynight,1,1") in new stack
  611. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (app-daynight,1,1)
  612. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1@app-daynight:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?ext-local,vmu100,1:ext-group,1000,1") in new stack
  613. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (ext-group,1000,1)
  614. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000019d", "user-callerid,") in new stack
  615. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/siptrunk.vpbx.net.au-0000019d", "TOUCH_MONITOR=1605219296.898") in new stack
  616. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "AMPUSER=0280603137") in new stack
  617. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/siptrunk.vpbx.net.au-0000019d", "HOTDESCKCHAN=siptrunk.vpbx.net.au-0000019d") in new stack
  618. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/siptrunk.vpbx.net.au-0000019d", "HOTDESKEXTEN=siptrunk.vpbx.net.au") in new stack
  619. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/siptrunk.vpbx.net.au-0000019d", "HOTDESKCALL=0") in new stack
  620. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(HOTDESKCALL=1)") in new stack
  621. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(CALLERID(name)=)") in new stack
  622. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?report") in new stack
  623. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?Set(REALCALLERIDNUM=0280603137)") in new stack
  624. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/siptrunk.vpbx.net.au-0000019d", "AMPUSER=") in new stack
  625. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?limit") in new stack
  626. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/siptrunk.vpbx.net.au-0000019d", "AMPUSERCIDNAME=") in new stack
  627. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  628. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?report") in new stack
  629. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (macro-user-callerid,s,29)
  630. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:29] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Macro Depth is 1") in new stack
  631. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?report2:macroerror") in new stack
  632. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (macro-user-callerid,s,31)
  633. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?continue") in new stack
  634. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  635. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:33] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__TTL=64") in new stack
  636. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?continue") in new stack
  637. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (macro-user-callerid,s,50)
  638. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:50] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CALLERID(number)=0280603137") in new stack
  639. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:51] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CALLERID(name)=0280603137") in new stack
  640. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?cnum") in new stack
  641. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:53] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CDR(cnam)=0280603137") in new stack
  642. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:54] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CDR(cnum)=0280603137") in new stack
  643. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-user-callerid:55] Set("SIP/siptrunk.vpbx.net.au-0000019d", "CHANNEL(language)=en_AU") in new stack
  644. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:2] Macro("SIP/siptrunk.vpbx.net.au-0000019d", "blkvm-setifempty,") in new stack
  645. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?init") in new stack
  646. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
  647. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__BLKVM_CHANNEL=SIP/siptrunk.vpbx.net.au-0000019d") in new stack
  648. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/siptrunk.vpbx.net.au-0000019d", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000019d)=TRUE") in new stack
  649. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/siptrunk.vpbx.net.au-0000019d", "GOSUB_RETVAL=TRUE") in new stack
  650. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  651. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?skipov") in new stack
  652. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (ext-group,1000,6)
  653. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:6] Set("SIP/siptrunk.vpbx.net.au-0000019d", "RRNODEST=") in new stack
  654. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:7] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__NODEST=1000") in new stack
  655. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:8] GosubIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?sub-rgsetcid,s,1()") in new stack
  656. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:9] Set("SIP/siptrunk.vpbx.net.au-0000019d", "_CFIGNORE=TRUE") in new stack
  657. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:10] Set("SIP/siptrunk.vpbx.net.au-0000019d", "_FORWARD_CONTEXT=block-cf") in new stack
  658. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:11] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__PICKUPMARK=1000") in new stack
  659. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:12] Gosub("SIP/siptrunk.vpbx.net.au-0000019d", "sub-record-check,s,1(rg,1000,dontcare)") in new stack
  660. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "10?initialized") in new stack
  661. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,s,10)
  662. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Recordings initialized") in new stack
  663. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ARG3=dontcare)") in new stack
  664. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000019d", "REC_POLICY_MODE_SAVE=") in new stack
  665. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(REC_STATUS=NO)") in new stack
  666. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "2?checkaction") in new stack
  667. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,s,17)
  668. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?sub-record-check,rg,1") in new stack
  669. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Generic rg Recording Check - 0280603137 1000") in new stack
  670. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/siptrunk.vpbx.net.au-0000019d", "recordcheck,1(dontcare,rg,1000)") in new stack
  671. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Starting recording check against dontcare") in new stack
  672. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000019d", "dontcare") in new stack
  673. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  674. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  675. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@sub-record-check:20] Return("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  676. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:13] Set("SIP/siptrunk.vpbx.net.au-0000019d", "RingGroupMethod=ringall") in new stack
  677. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:14] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__ALT_CONFIRM_MSG=") in new stack
  678. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:15] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
  679. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (ext-group,1000,18)
  680. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [1000@ext-group:18] Macro("SIP/siptrunk.vpbx.net.au-0000019d", "dial,30,HhTtrQ(ANSWERED_ELSEWHERE),100-113") in new stack
  681. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  682. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:2] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__CRM_SOURCE=0280603137") in new stack
  683. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ALERT_INFO=)") in new stack
  684. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ALERT_INFO=)") in new stack
  685. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ALERT_INFO=)") in new stack
  686. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(CHANNEL(musicclass)=)") in new stack
  687. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:7] AGI("SIP/siptrunk.vpbx.net.au-0000019d", "dialparties.agi") in new stack
  688. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  689. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Starting New Dialparties.agi
  690. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Caller ID name is '0280603137' number is '0280603137'
  691. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: CW Ignore is:
  692. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: CF Ignore is: TRUE
  693. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
  694. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'
  695. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Added extension 100 to extension map
  696. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Added extension 113 to extension map
  697. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Extension 100 cf is disabled
  698. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Extension 113 cf is disabled
  699. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Extension 100 do not disturb is disabled
  700. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Extension 113 do not disturb is disabled
  701. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/100
  702. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Ended up with real PJSIP Dial string PJSIP/100/sip:100@192.168.0.53:5060
  703. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: dbset CALLTRACE/100 to 0280603137
  704. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/113
  705. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
  706. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: dbset CALLTRACE/113 to 0280603137
  707. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: Filtered ARG3: 100-113
  708. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: RVOL_MODE ''
  709. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: RVOL is:
  710. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: dialparties.agi: RVOLPARENT is:
  711. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000019d>AGI Script dialparties.agi completed, returning 0
  712. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:10] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Returned from dialparties with groups to dial") in new stack
  713. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:11] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "ringall array ") in new stack
  714. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:12] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__FMGL_DIAL=") in new stack
  715. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:13] Set("SIP/siptrunk.vpbx.net.au-0000019d", "LOOPCNT=2") in new stack
  716. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:14] Set("SIP/siptrunk.vpbx.net.au-0000019d", "ITER=1") in new stack
  717. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__EXTTOCALL=100") in new stack
  718. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Working with 100") in new stack
  719. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  720. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  721. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000019d", "ITER=2") in new stack
  722. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "1?ndloopbegin") in new stack
  723. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx_builtins.c: Goto (macro-dial,s,15)
  724. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000019d", "__EXTTOCALL=113") in new stack
  725. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000019d", "Working with 113") in new stack
  726. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  727. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  728. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000019d", "ITER=3") in new stack
  729. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?ndloopbegin") in new stack
  730. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:21] Macro("SIP/siptrunk.vpbx.net.au-0000019d", "dial-ringall-predial-hook,") in new stack
  731. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/siptrunk.vpbx.net.au-0000019d", "") in new stack
  732. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:22] ExecIf("SIP/siptrunk.vpbx.net.au-0000019d", "0?Set(ds=PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)g)") in new stack
  733. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-dial:23] Dial("SIP/siptrunk.vpbx.net.au-0000019d", "PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
  734. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_stack.c: PJSIP/100-000001a9 Internal Gosub(func-apply-sipheaders,s,1) start
  735. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/100-000001a9", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  736. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/100-000001a9", "Applying SIP Headers to channel PJSIP/100-000001a9") in new stack
  737. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/100-000001a9", "TECH=PJSIP") in new stack
  738. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/100-000001a9", "SIPHEADERKEYS=") in new stack
  739. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/100-000001a9", "0") in new stack
  740. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_while.c: Jumping to priority 13
  741. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/100-000001a9", "") in new stack
  742. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_stack.c: Spawn extension (from-internal, 1000, 1) exited non-zero on 'PJSIP/100-000001a9'
  743. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_stack.c: PJSIP/100-000001a9 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  744. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_dial.c: Called PJSIP/100/sip:100@192.168.0.53:5060
  745. [2020-11-12 22:14:57] VERBOSE[3337] netsock2.c: Using SIP RTP Audio TOS bits 184
  746. [2020-11-12 22:14:57] VERBOSE[3337] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  747. [2020-11-12 22:14:57] VERBOSE[3337] netsock2.c: Using SIP RTP Audio CoS mark 5
  748. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_dial.c: PJSIP/100-000001a9 is ringing
  749. [2020-11-12 22:14:57] VERBOSE[11841][C-000001c8] app_dial.c: PJSIP/100-000001a9 is ringing
  750. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] app_dial.c: PJSIP/100-000001a9 answered SIP/siptrunk.vpbx.net.au-0000019d
  751. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:1] Set("PJSIP/100-000001a9", "__MACRO_RESULT=") in new stack
  752. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:2] Set("PJSIP/100-000001a9", "CFIGNORE=") in new stack
  753. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:3] Set("PJSIP/100-000001a9", "MASTER_CHANNEL(CFIGNORE)=") in new stack
  754. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:4] Set("PJSIP/100-000001a9", "FORWARD_CONTEXT=from-internal") in new stack
  755. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:5] Set("PJSIP/100-000001a9", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
  756. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("PJSIP/100-000001a9", "blkvm-clr,") in new stack
  757. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-clr:1] Set("PJSIP/100-000001a9", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000019d)=") in new stack
  758. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-clr:2] Set("PJSIP/100-000001a9", "GOSUB_RETVAL=") in new stack
  759. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("PJSIP/100-000001a9", "") in new stack
  760. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("PJSIP/100-000001a9", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=100/sip:100@192.168.0.53:5060)") in new stack
  761. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("PJSIP/100-000001a9", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
  762. [2020-11-12 22:15:00] VERBOSE[11962][C-000001c8] bridge_channel.c: Channel PJSIP/100-000001a9 joined 'simple_bridge' basic-bridge <31008275-151e-4111-96ce-73b45f08792a>
  763. [2020-11-12 22:15:00] VERBOSE[11841][C-000001c8] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000019d joined 'simple_bridge' basic-bridge <31008275-151e-4111-96ce-73b45f08792a>
  764. [2020-11-12 22:15:21] VERBOSE[19480] pbx_variables.c: Setting global variable 'SIPDOMAIN' to 'pabx.voip.mpknetwork.net'
  765. [2020-11-12 22:15:21] VERBOSE[19480] netsock2.c: Using SIP RTP Audio TOS bits 184
  766. [2020-11-12 22:15:21] VERBOSE[19480] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  767. [2020-11-12 22:15:21] VERBOSE[19480] netsock2.c: Using SIP RTP Audio CoS mark 5
  768. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [107@from-internal:1] GotoIf("PJSIP/100-000001aa", "1?ext-local,107,1:followme-check,107,1") in new stack
  769. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (ext-local,107,1)
  770. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [107@ext-local:1] Set("PJSIP/100-000001aa", "__RINGTIMER=15") in new stack
  771. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [107@ext-local:2] ExecIf("PJSIP/100-000001aa", "0?Set(__CWIGNORE=)") in new stack
  772. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [107@ext-local:3] Macro("PJSIP/100-000001aa", "exten-vm,novm,107,0,0,0") in new stack
  773. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/100-000001aa", "user-callerid,") in new stack
  774. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/100-000001aa", "TOUCH_MONITOR=1605219321.900") in new stack
  775. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/100-000001aa", "AMPUSER=100") in new stack
  776. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/100-000001aa", "HOTDESCKCHAN=100-000001aa") in new stack
  777. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/100-000001aa", "HOTDESKEXTEN=100") in new stack
  778. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/100-000001aa", "HOTDESKCALL=0") in new stack
  779. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("PJSIP/100-000001aa", "0?Set(HOTDESKCALL=1)") in new stack
  780. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("PJSIP/100-000001aa", "0?Set(CALLERID(name)=)") in new stack
  781. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/100-000001aa", "0?report") in new stack
  782. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("PJSIP/100-000001aa", "1?Set(REALCALLERIDNUM=100)") in new stack
  783. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/100-000001aa", "AMPUSER=100") in new stack
  784. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("PJSIP/100-000001aa", "0?limit") in new stack
  785. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/100-000001aa", "AMPUSERCIDNAME=Reception R") in new stack
  786. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/100-000001aa", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  787. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/100-000001aa", "0?report") in new stack
  788. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/100-000001aa", "AMPUSERCID=100") in new stack
  789. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:16] Set("PJSIP/100-000001aa", "__DIAL_OPTIONS=HhTtr") in new stack
  790. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/100-000001aa", "CALLERID(all)="Reception R" <100>") in new stack
  791. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:18] Set("PJSIP/100-000001aa", "HOTDESCKCHAN=100-000001aa") in new stack
  792. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:19] Set("PJSIP/100-000001aa", "HOTDESKEXTEN=100") in new stack
  793. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/100-000001aa", "HOTDESKCALL=0") in new stack
  794. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("PJSIP/100-000001aa", "0?Set(HOTDESKCALL=1)") in new stack
  795. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("PJSIP/100-000001aa", "0?Set(CALLERID(name)=)") in new stack
  796. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/100-000001aa", "0?Set(CALLERID(all)="" < >)") in new stack
  797. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/100-000001aa", "0?Set(CUSDIAL=107)") in new stack
  798. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("PJSIP/100-000001aa", "0?Set(CALLERID(all)="Reception R" <100>)") in new stack
  799. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:26] GotoIf("PJSIP/100-000001aa", "0?limit") in new stack
  800. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/100-000001aa", "0?Set(GROUP(concurrency_limit)=100)") in new stack
  801. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:28] ExecIf("PJSIP/100-000001aa", "0?Set(CHANNEL(language)=)") in new stack
  802. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/100-000001aa", "Macro Depth is 2") in new stack
  803. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/100-000001aa", "1?report2:macroerror") in new stack
  804. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-user-callerid,s,31)
  805. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/100-000001aa", "0?continue") in new stack
  806. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("PJSIP/100-000001aa", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  807. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/100-000001aa", "__TTL=64") in new stack
  808. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("PJSIP/100-000001aa", "1?continue") in new stack
  809. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-user-callerid,s,50)
  810. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/100-000001aa", "CALLERID(number)=100") in new stack
  811. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/100-000001aa", "CALLERID(name)=Reception R") in new stack
  812. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/100-000001aa", "0?cnum") in new stack
  813. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/100-000001aa", "CDR(cnam)=Reception R") in new stack
  814. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/100-000001aa", "CDR(cnum)=100") in new stack
  815. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/100-000001aa", "CHANNEL(language)=en_AU") in new stack
  816. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/100-000001aa", "RingGroupMethod=none") in new stack
  817. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/100-000001aa", "__EXTTOCALL=107") in new stack
  818. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/100-000001aa", "__PICKUPMARK=107") in new stack
  819. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/100-000001aa", "RT=") in new stack
  820. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  821. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/100-000001aa", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
  822. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  823. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  824. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  825. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  826. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  827. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:8] ExecIf("PJSIP/100-000001aa", "0?Gosub(ext-intercom,*80107,1())") in new stack
  828. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  829. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  830. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:9] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  831. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  832. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  833. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:10] ExecIf("PJSIP/100-000001aa", "0?ChanSpy(PJSIP/107,q)") in new stack
  834. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  835. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  836. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  837. [2020-11-12 22:15:21] WARNING[12865][C-000001c9] chan_sip.c: This function can only be used on SIP channels.
  838. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:12] ExecIf("PJSIP/100-000001aa", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
  839. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:13] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  840. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:14] ExecIf("PJSIP/100-000001aa", "0?Gosub(ext-intercom,*80107,1())") in new stack
  841. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:15] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  842. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:16] ExecIf("PJSIP/100-000001aa", "0?ChanSpy(PJSIP/107,q)") in new stack
  843. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:17] ExecIf("PJSIP/100-000001aa", "0?MacroExit()") in new stack
  844. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:18] Gosub("PJSIP/100-000001aa", "sub-record-check,s,1(exten,107,dontcare)") in new stack
  845. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/100-000001aa", "0?initialized") in new stack
  846. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/100-000001aa", "__REC_STATUS=INITIALIZED") in new stack
  847. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/100-000001aa", "NOW=1605219321") in new stack
  848. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/100-000001aa", "__DAY=12") in new stack
  849. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/100-000001aa", "__MONTH=11") in new stack
  850. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/100-000001aa", "__YEAR=2020") in new stack
  851. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/100-000001aa", "__TIMESTR=20201112-221521") in new stack
  852. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/100-000001aa", "__FROMEXTEN=100") in new stack
  853. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/100-000001aa", "__MON_FMT=wav") in new stack
  854. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/100-000001aa", "Recordings initialized") in new stack
  855. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/100-000001aa", "0?Set(ARG3=dontcare)") in new stack
  856. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/100-000001aa", "REC_POLICY_MODE_SAVE=") in new stack
  857. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/100-000001aa", "0?Set(REC_STATUS=NO)") in new stack
  858. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/100-000001aa", "5?checkaction") in new stack
  859. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (sub-record-check,s,17)
  860. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/100-000001aa", "1?sub-record-check,exten,1") in new stack
  861. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (sub-record-check,exten,1)
  862. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/100-000001aa", "Exten Recording Check between 100 and 107") in new stack
  863. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/100-000001aa", "CALLTYPE=internal") in new stack
  864. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/100-000001aa", "0?Set(CALLTYPE=)") in new stack
  865. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/100-000001aa", "CALLEE=dontcare") in new stack
  866. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/100-000001aa", "0?Set(CALLEE=dontcare)") in new stack
  867. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/100-000001aa", "0?callee") in new stack
  868. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/100-000001aa", "1?caller") in new stack
  869. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (sub-record-check,exten,13)
  870. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/100-000001aa", "RECMODE=dontcare") in new stack
  871. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/100-000001aa", "0?Set(RECMODE=dontcare)") in new stack
  872. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/100-000001aa", "1?Set(RECMODE=dontcare)") in new stack
  873. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/100-000001aa", "recordcheck,1(dontcare,internal,107)") in new stack
  874. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/100-000001aa", "Starting recording check against dontcare") in new stack
  875. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/100-000001aa", "dontcare") in new stack
  876. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  877. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/100-000001aa", "") in new stack
  878. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/100-000001aa", "") in new stack
  879. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:19] GotoIf("PJSIP/100-000001aa", "1?macrodial") in new stack
  880. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-exten-vm,s,25)
  881. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:25] GosubIf("PJSIP/100-000001aa", "0?clrheader,1()") in new stack
  882. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-exten-vm:26] Macro("PJSIP/100-000001aa", "dial-one,,HhTtr,107") in new stack
  883. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/100-000001aa", "DEXTEN=107") in new stack
  884. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/100-000001aa", "__CRM_SOURCE=100") in new stack
  885. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:3] ExecIf("PJSIP/100-000001aa", "0?Set(__EXTTOCALL=107)") in new stack
  886. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:4] Set("PJSIP/100-000001aa", "DIALSTATUS_CW=") in new stack
  887. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/100-000001aa", "0?screen,1()") in new stack
  888. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/100-000001aa", "0?cf,1()") in new stack
  889. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:7] GotoIf("PJSIP/100-000001aa", "1?skip1") in new stack
  890. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-dial-one,s,10)
  891. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/100-000001aa", "0?nodial") in new stack
  892. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/100-000001aa", "0?continue") in new stack
  893. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:12] Set("PJSIP/100-000001aa", "EXTHASCW=ENABLED") in new stack
  894. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:13] GotoIf("PJSIP/100-000001aa", "0?next1:cwinusebusy") in new stack
  895. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-dial-one,s,25)
  896. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:25] GotoIf("PJSIP/100-000001aa", "0?next3:continue") in new stack
  897. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-dial-one,s,27)
  898. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:27] GotoIf("PJSIP/100-000001aa", "0?nodial") in new stack
  899. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:28] GosubIf("PJSIP/100-000001aa", "1?dstring,1():dlocal,1()") in new stack
  900. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/100-000001aa", "DSTRING=") in new stack
  901. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/100-000001aa", "DEVICES=107") in new stack
  902. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/100-000001aa", "0?Return()") in new stack
  903. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/100-000001aa", "0?Set(DEVICES=07)") in new stack
  904. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/100-000001aa", "LOOPCNT=1") in new stack
  905. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/100-000001aa", "ITER=1") in new stack
  906. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/100-000001aa", "THISDIAL=PJSIP/107") in new stack
  907. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/100-000001aa", "1?zap2dahdi,1()") in new stack
  908. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/100-000001aa", "0?Return()") in new stack
  909. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/100-000001aa", "NEWDIAL=") in new stack
  910. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/100-000001aa", "LOOPCNT2=1") in new stack
  911. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/100-000001aa", "ITER2=1") in new stack
  912. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/100-000001aa", "THISPART2=PJSIP/107") in new stack
  913. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/100-000001aa", "0?Set(THISPART2=DAHDIIP/107)") in new stack
  914. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/100-000001aa", "NEWDIAL=PJSIP/107&") in new stack
  915. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/100-000001aa", "ITER2=2") in new stack
  916. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/100-000001aa", "0?begin2") in new stack
  917. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/100-000001aa", "THISDIAL=PJSIP/107") in new stack
  918. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/100-000001aa", "") in new stack
  919. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/100-000001aa", "0?docheck") in new stack
  920. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:10] NoOp("PJSIP/100-000001aa", "Debug: Found PJSIP Destination PJSIP/107") in new stack
  921. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf("PJSIP/100-000001aa", "0?doset") in new stack
  922. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:12] NoOp("PJSIP/100-000001aa", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
  923. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:13] Set("PJSIP/100-000001aa", "THISDIAL=PJSIP/107/sip:107@192.168.0.55:5060") in new stack
  924. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:14] ExecIf("PJSIP/100-000001aa", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
  925. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf("PJSIP/100-000001aa", "0?skipset") in new stack
  926. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/100-000001aa", "DSTRING=PJSIP/107/sip:107@192.168.0.55:5060&") in new stack
  927. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:17] Set("PJSIP/100-000001aa", "ITER=2") in new stack
  928. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:18] GotoIf("PJSIP/100-000001aa", "0?begin") in new stack
  929. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:19] ExecIf("PJSIP/100-000001aa", "0?Return()") in new stack
  930. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:20] Set("PJSIP/100-000001aa", "DSTRING=PJSIP/107/sip:107@192.168.0.55:5060") in new stack
  931. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [dstring@macro-dial-one:21] Return("PJSIP/100-000001aa", "") in new stack
  932. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:29] GotoIf("PJSIP/100-000001aa", "0?nodial") in new stack
  933. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/100-000001aa", "0?skiptrace") in new stack
  934. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:31] GosubIf("PJSIP/100-000001aa", "1?ctset,1():ctclear,1()") in new stack
  935. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/100-000001aa", "DB(CALLTRACE/107)=100") in new stack
  936. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/100-000001aa", "") in new stack
  937. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:32] Set("PJSIP/100-000001aa", "D_OPTIONS=HhTtr") in new stack
  938. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:33] GosubIf("PJSIP/100-000001aa", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  939. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:34] NoOp("PJSIP/100-000001aa", "Blind Transfer: , Attended Transfer: , User: 100, Alert Info: ") in new stack
  940. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:35] ExecIf("PJSIP/100-000001aa", "1?Set(ALERT_INFO=)") in new stack
  941. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/100-000001aa", "0?Set(ALERT_INFO=)") in new stack
  942. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/100-000001aa", "0?Set(ALERT_INFO=)") in new stack
  943. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/100-000001aa", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  944. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/100-000001aa", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  945. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:40] GosubIf("PJSIP/100-000001aa", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  946. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:41] ExecIf("PJSIP/100-000001aa", "0?Set(CHANNEL(musicclass)=)") in new stack
  947. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:42] GosubIf("PJSIP/100-000001aa", "0?qwait,1()") in new stack
  948. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:43] Set("PJSIP/100-000001aa", "__CWIGNORE=") in new stack
  949. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:44] Set("PJSIP/100-000001aa", "__KEEPCID=TRUE") in new stack
  950. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:45] GotoIf("PJSIP/100-000001aa", "0?usegoto,1") in new stack
  951. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:46] GotoIf("PJSIP/100-000001aa", "0?godial") in new stack
  952. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:47] Gosub("PJSIP/100-000001aa", "sub-presencestate-display,s,1(107)") in new stack
  953. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@sub-presencestate-display:1] Goto("PJSIP/100-000001aa", "state-available,1") in new stack
  954. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (sub-presencestate-display,state-available,1)
  955. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [state-available@sub-presencestate-display:1] Set("PJSIP/100-000001aa", "PRESENCESTATE_DISPLAY=(Available)") in new stack
  956. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [state-available@sub-presencestate-display:2] Return("PJSIP/100-000001aa", "") in new stack
  957. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:48] Set("PJSIP/100-000001aa", "CONNECTEDLINE(name,i)=Chris(Available)") in new stack
  958. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:49] Set("PJSIP/100-000001aa", "CONNECTEDLINE(num)=107") in new stack
  959. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:50] Set("PJSIP/100-000001aa", "D_OPTIONS=HhTtr") in new stack
  960. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:51] Macro("PJSIP/100-000001aa", "dialout-one-predial-hook,") in new stack
  961. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("PJSIP/100-000001aa", "") in new stack
  962. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:52] ExecIf("PJSIP/100-000001aa", "0?Set(D_OPTIONS=HhtrI)") in new stack
  963. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:53] NoOp("PJSIP/100-000001aa", "") in new stack
  964. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:54] ExecIf("PJSIP/100-000001aa", "0?Set(D_OPTIONS=HhTtrg)") in new stack
  965. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-dial-one:55] Dial("PJSIP/100-000001aa", "PJSIP/107/sip:107@192.168.0.55:5060,,HhTtrb(func-apply-sipheaders^s^1)") in new stack
  966. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_stack.c: PJSIP/107-000001ab Internal Gosub(func-apply-sipheaders,s,1) start
  967. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/107-000001ab", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  968. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/107-000001ab", "Applying SIP Headers to channel PJSIP/107-000001ab") in new stack
  969. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/107-000001ab", "TECH=PJSIP") in new stack
  970. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/107-000001ab", "SIPHEADERKEYS=") in new stack
  971. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/107-000001ab", "0") in new stack
  972. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_while.c: Jumping to priority 13
  973. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/107-000001ab", "") in new stack
  974. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_stack.c: Spawn extension (from-internal, 107, 1) exited non-zero on 'PJSIP/107-000001ab'
  975. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_stack.c: PJSIP/107-000001ab Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  976. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_dial.c: Called PJSIP/107/sip:107@192.168.0.55:5060
  977. [2020-11-12 22:15:21] VERBOSE[28083] netsock2.c: Using SIP RTP Audio TOS bits 184
  978. [2020-11-12 22:15:21] VERBOSE[28083] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  979. [2020-11-12 22:15:21] VERBOSE[28083] netsock2.c: Using SIP RTP Audio CoS mark 5
  980. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_dial.c: PJSIP/107-000001ab is ringing
  981. [2020-11-12 22:15:21] VERBOSE[12865][C-000001c9] app_dial.c: PJSIP/107-000001ab is ringing
  982. [2020-11-12 22:15:24] VERBOSE[12865][C-000001c9] app_dial.c: PJSIP/107-000001ab answered PJSIP/100-000001aa
  983. [2020-11-12 22:15:24] VERBOSE[12967][C-000001c9] bridge_channel.c: Channel PJSIP/107-000001ab joined 'simple_bridge' basic-bridge <196a2678-6f29-4b7e-8bbc-f8ba84225b7e>
  984. [2020-11-12 22:15:24] VERBOSE[12865][C-000001c9] bridge_channel.c: Channel PJSIP/100-000001aa joined 'simple_bridge' basic-bridge <196a2678-6f29-4b7e-8bbc-f8ba84225b7e>
  985. [2020-11-12 22:16:01] NOTICE[11828] res_pjsip_sdp_rtp.c: Disconnecting channel 'PJSIP/100-000001aa' for lack of RTP activity in 30 seconds
  986. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] bridge_channel.c: Channel PJSIP/100-000001aa left 'simple_bridge' basic-bridge <196a2678-6f29-4b7e-8bbc-f8ba84225b7e>
  987. [2020-11-12 22:16:01] VERBOSE[12967][C-000001c9] bridge_channel.c: Channel PJSIP/107-000001ab left 'simple_bridge' basic-bridge <196a2678-6f29-4b7e-8bbc-f8ba84225b7e>
  988. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] app_macro.c: Spawn extension (macro-dial-one, s, 55) exited non-zero on 'PJSIP/100-000001aa' in macro 'dial-one'
  989. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] app_macro.c: Spawn extension (macro-exten-vm, s, 26) exited non-zero on 'PJSIP/100-000001aa' in macro 'exten-vm'
  990. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Spawn extension (ext-local, 107, 3) exited non-zero on 'PJSIP/100-000001aa'
  991. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/100-000001aa", "hangupcall,") in new stack
  992. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/100-000001aa", "1?theend") in new stack
  993. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  994. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/100-000001aa", "0?Set(CDR(recordingfile)=)") in new stack
  995. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/100-000001aa", "PJSIP/107-000001ab montior file= ") in new stack
  996. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/100-000001aa", "1?skipagi") in new stack
  997. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx_builtins.c: Goto (macro-hangupcall,s,7)
  998. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/100-000001aa", "") in new stack
  999. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/100-000001aa' in macro 'hangupcall'
  1000. [2020-11-12 22:16:01] VERBOSE[12865][C-000001c9] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/100-000001aa'

Reply to "Logs transfer"

Here you can reply to the paste above

Powered by Stikked