FreePBX Pastebin

queue trace

From craig.arnold, 5 Days ago, written in Plain Text, viewed 1 times. This paste will slip away in 3 Weeks.
URL https://pastebin.freepbx.org/view/df135ae4 Embed
Download Paste or View Raw
  1. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:1] Set("PJSIP/thinktel-edm-0002138b", "__DIRECTION=INBOUND") in new stack
  2. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:2] Gosub("PJSIP/thinktel-edm-0002138b", "sub-record-check,s,1(in,780DIDXXXX,dontcare)") in new stack
  3. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/thinktel-edm-0002138b", "0?initialized") in new stack
  4. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/thinktel-edm-0002138b", "__REC_STATUS=INITIALIZED") in new stack
  5. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/thinktel-edm-0002138b", "NOW=1756935698") in new stack
  6. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/thinktel-edm-0002138b", "__DAY=03") in new stack
  7. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/thinktel-edm-0002138b", "__MONTH=09") in new stack
  8. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/thinktel-edm-0002138b", "__YEAR=2025") in new stack
  9. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/thinktel-edm-0002138b", "__TIMESTR=20250903-154138") in new stack
  10. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/thinktel-edm-0002138b", "__FROMEXTEN=unknown") in new stack
  11. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/thinktel-edm-0002138b", "__MON_FMT=wav") in new stack
  12. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/thinktel-edm-0002138b", "Recordings initialized") in new stack
  13. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(ARG3=dontcare)") in new stack
  14. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/thinktel-edm-0002138b", "REC_POLICY_MODE_SAVE=") in new stack
  15. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(REC_STATUS=NO)") in new stack
  16. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/thinktel-edm-0002138b", "2?checkaction") in new stack
  17. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  18. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/thinktel-edm-0002138b", "1?sub-record-check,in,1") in new stack
  19. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,in,1)
  20. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/thinktel-edm-0002138b", "Inbound Recording Check to 780DIDXXXX") in new stack
  21. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/thinktel-edm-0002138b", "FROMEXTEN=unknown") in new stack
  22. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/thinktel-edm-0002138b", "10?Set(FROMEXTEN=780CALLERX)") in new stack
  23. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/thinktel-edm-0002138b", "recordcheck,1(dontcare,in,780DIDXXXX)") in new stack
  24. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/thinktel-edm-0002138b", "Starting recording check against dontcare") in new stack
  25. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/thinktel-edm-0002138b", "dontcare") in new stack
  26. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  27. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  28. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  29. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:3] Set("PJSIP/thinktel-edm-0002138b", "CHANNEL(tonezone)=us") in new stack
  30. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:4] Set("PJSIP/thinktel-edm-0002138b", "__FROM_DID=780DIDXXXX") in new stack
  31. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:5] Set("PJSIP/thinktel-edm-0002138b", "returnhere=1") in new stack
  32. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:6] Gosub("PJSIP/thinktel-edm-0002138b", "app-blacklist-check,s,1()") in new stack
  33. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/thinktel-edm-0002138b", "0?blacklisted") in new stack
  34. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/thinktel-edm-0002138b", "CALLED_BLACKLIST=1") in new stack
  35. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  36. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:7] Set("PJSIP/thinktel-edm-0002138b", "CDR(did)=780DIDXXXX") in new stack
  37. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:8] GotoIf("PJSIP/thinktel-edm-0002138b", "0?") in new stack
  38. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:9] ExecIf("PJSIP/thinktel-edm-0002138b", "1 ?Set(CALLERID(name)=780CALLERX)") in new stack
  39. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:10] Set("PJSIP/thinktel-edm-0002138b", "__MOHCLASS=") in new stack
  40. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:11] Set("PJSIP/thinktel-edm-0002138b", "__REVERSAL_REJECT=FALSE") in new stack
  41. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:12] GotoIf("PJSIP/thinktel-edm-0002138b", "1?post-reverse-charge") in new stack
  42. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (from-pstn,780DIDXXXX,14)
  43. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:14] NoOp("PJSIP/thinktel-edm-0002138b", "") in new stack
  44. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:15] Set("PJSIP/thinktel-edm-0002138b", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  45. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:16] Set("PJSIP/thinktel-edm-0002138b", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  46. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:17] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(name-pres)=allowed_not_screened") in new stack
  47. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:18] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(num-pres)=allowed_not_screened") in new stack
  48. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:19] NoOp("PJSIP/thinktel-edm-0002138b", "CallerID Entry Point") in new stack
  49. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:20] Set("PJSIP/thinktel-edm-0002138b", "__CRM_DIRECTION=INBOUND") in new stack
  50. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:21] Set("PJSIP/thinktel-edm-0002138b", "__CRM_SOURCE=780CALLERX") in new stack
  51. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:22] Set("PJSIP/thinktel-edm-0002138b", "__CRM_LINKEDID=1756935698.213397") in new stack
  52. [2025-09-03 15:41:38] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:23] AGI("PJSIP/thinktel-edm-0002138b", "agi://127.0.0.1/sangomacrm.agi,true") in new stack
  53. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: LINKEDID: 1756935698.213397
  54. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: SOURCE: 780CALLERX
  55. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: DESTINATION:
  56. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: DIRECTION: INBOUND
  57. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: EXTTOCALL:
  58. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: START
  59. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi,true: SCRIPT: php /var/www/html/admin/modules/sangomacrm/importOne.php 'eyJ1dWlkIjoiMTc1NjkzNTY5OC4yMTMzOTciLCJzb3VyY2UiOiI3ODAyODkwMDY0IiwiZGVzdGluYXRpb24iOiIiLCJkaXJlY3Rpb24iOiJJTkJPVU5EIiwidHlwZSI6IlNUQVJUIiwienVsdV9yYXdfdHlwZSI6IiIsInp1bHVfdHlwZSI6IiIsInp1bHVfdXJsIjoiIiwiZXh0dG9jYWxsIjoiIiwiY251bSI6Ijc4MDI4OTAwNjQiLCJjbmFtIjoiNzgwMjg5MDA2NCIsImNhbGxwb3AiOnRydWUsInZvaWNlbWFpbCI6IiIsImZyb21fZGlkIjoiNzgwNDE5NjU0MCJ9' > /dev/null 2>&1 &
  60. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] res_agi.c: <PJSIP/thinktel-edm-0002138b>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  61. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:24] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  62. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [780DIDXXXX@from-pstn:25] Goto("PJSIP/thinktel-edm-0002138b", "timeconditions,14,1") in new stack
  63. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (timeconditions,14,1)
  64. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:1] Set("PJSIP/thinktel-edm-0002138b", "DB(TC/14/INUSESTATE)=INUSE") in new stack
  65. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:2] Set("PJSIP/thinktel-edm-0002138b", "DB(TC/14/NOT_INUSESTATE)=NOT_INUSE") in new stack
  66. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:3] NoOp("PJSIP/thinktel-edm-0002138b", "TIMENOW: 15:41,Wed, 3,Sep") in new stack
  67. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:4] NoOp("PJSIP/thinktel-edm-0002138b", "TIMEMATCHED: TRUE") in new stack
  68. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:5] GotoIfTime("PJSIP/thinktel-edm-0002138b", "07:30-16:30,mon-fri,1-31,jan-dec?truestate") in new stack
  69. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (timeconditions,14,14)
  70. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:14] GotoIf("PJSIP/thinktel-edm-0002138b", "0?falsegoto") in new stack
  71. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:15] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(DB(TC/14)=)") in new stack
  72. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:16] Set("PJSIP/thinktel-edm-0002138b", "DEVICE_STATE(Custom:TC14)=NOT_INUSE") in new stack
  73. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:17] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
  74. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [14@timeconditions:18] GotoIf("PJSIP/thinktel-edm-0002138b", "1?ext-queues,540,1") in new stack
  75. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (ext-queues,540,1)
  76. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:1] Gosub("PJSIP/thinktel-edm-0002138b", "macro-user-callerid,s,1()") in new stack
  77. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/thinktel-edm-0002138b", "TOUCH_MONITOR=1756935698.213397") in new stack
  78. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/thinktel-edm-0002138b", "CHANCONTEXT=") in new stack
  79. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/thinktel-edm-0002138b", "CHANCONTEXT=") in new stack
  80. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/thinktel-edm-0002138b", "CHANEXTENCONTEXT=thinktel-edm-0002138b") in new stack
  81. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/thinktel-edm-0002138b", "CHANEXTEN=thinktel-edm-0002138b") in new stack
  82. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(number)=780CALLERX") in new stack
  83. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/thinktel-edm-0002138b", "AMPUSER=780CALLERX") in new stack
  84. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/thinktel-edm-0002138b", "HOTDESCKCHAN=thinktel-edm-0002138b") in new stack
  85. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/thinktel-edm-0002138b", "HOTDESKEXTEN=thinktel") in new stack
  86. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/thinktel-edm-0002138b", "HOTDESKCALL=0") in new stack
  87. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(HOTDESKCALL=1)") in new stack
  88. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(CALLERID(name)=)") in new stack
  89. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/thinktel-edm-0002138b", "0?report") in new stack
  90. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(REALCALLERIDNUM=780CALLERX)") in new stack
  91. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/thinktel-edm-0002138b", "AMPUSER=") in new stack
  92. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/thinktel-edm-0002138b", "0?limit") in new stack
  93. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/thinktel-edm-0002138b", "AMPUSERCIDNAME=") in new stack
  94. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  95. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/thinktel-edm-0002138b", "1?report") in new stack
  96. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-user-callerid,s,28)
  97. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/thinktel-edm-0002138b", "Macro depricated!! To keep the same line numbers") in new stack
  98. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/thinktel-edm-0002138b", "Macro depricated !!  To keep the same line numbers") in new stack
  99. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/thinktel-edm-0002138b", "0?continue") in new stack
  100. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:31] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  101. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:32] Set("PJSIP/thinktel-edm-0002138b", "__TTL=64") in new stack
  102. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:33] GotoIf("PJSIP/thinktel-edm-0002138b", "1?continue") in new stack
  103. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-user-callerid,s,49)
  104. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(number)=780CALLERX") in new stack
  105. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(name)=780CALLERX") in new stack
  106. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("PJSIP/thinktel-edm-0002138b", "0?cnum") in new stack
  107. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/thinktel-edm-0002138b", "__MCNUM=780CALLERX") in new stack
  108. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/thinktel-edm-0002138b", "__MCNAME=780CALLERX") in new stack
  109. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/thinktel-edm-0002138b", "__MCEXTEN=") in new stack
  110. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/thinktel-edm-0002138b", "__MCORGCHAN=PJSIP/thinktel-edm-0002138b") in new stack
  111. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:56] Set("PJSIP/thinktel-edm-0002138b", "CDR(cnam)=780CALLERX") in new stack
  112. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:57] Set("PJSIP/thinktel-edm-0002138b", "CDR(cnum)=780CALLERX") in new stack
  113. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:58] GosubIf("PJSIP/thinktel-edm-0002138b", "0?app-check-classofservce,s,1()") in new stack
  114. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:59] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  115. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:2] Set("PJSIP/thinktel-edm-0002138b", "__MCQUEUE=540") in new stack
  116. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:3] Answer("PJSIP/thinktel-edm-0002138b", "") in new stack
  117. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:4] Set("PJSIP/thinktel-edm-0002138b", "__FROMQUEUEEXTEN=780CALLERX") in new stack
  118. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:5] Gosub("PJSIP/thinktel-edm-0002138b", "macro-blkvm-set,s,1(reset)") in new stack
  119. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-set:1] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(__BLKVM_CHANNEL=PJSIP/thinktel-edm-0002138b)") in new stack
  120. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-set:2] Set("PJSIP/thinktel-edm-0002138b", "SHARED(BLKVM,PJSIP/thinktel-edm-0002138b)=TRUE") in new stack
  121. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-set:3] Set("PJSIP/thinktel-edm-0002138b", "GOSUB_RETVAL=TRUE") in new stack
  122. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-set:4] Return("PJSIP/thinktel-edm-0002138b", "TRUE") in new stack
  123. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:6] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(_DIAL_OPTIONS=HhTtrU(macro-auto-blkvm))") in new stack
  124. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:7] Set("PJSIP/thinktel-edm-0002138b", "__NODEST=540") in new stack
  125. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:8] Set("PJSIP/thinktel-edm-0002138b", "__QCONTEXT=1") in new stack
  126. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:9] Set("PJSIP/thinktel-edm-0002138b", "QCIDPP=Transp:") in new stack
  127. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:10] Set("PJSIP/thinktel-edm-0002138b", "VQ_CIDPP=") in new stack
  128. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:11] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Gosub(macro-prepend-cid,s,1(Transp:))") in new stack
  129. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-prepend-cid:1] GotoIf("PJSIP/thinktel-edm-0002138b", "1?REPCID") in new stack
  130. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-prepend-cid,s,5)
  131. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-prepend-cid:5] Set("PJSIP/thinktel-edm-0002138b", "_RGPREFIX=Transp:") in new stack
  132. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-prepend-cid:6] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(name)=Transp:780CALLERX") in new stack
  133. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-prepend-cid:7] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  134. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:12] Set("PJSIP/thinktel-edm-0002138b", "QAINFO=") in new stack
  135. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:13] Set("PJSIP/thinktel-edm-0002138b", "VQ_AINFO=") in new stack
  136. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:14] Set("PJSIP/thinktel-edm-0002138b", "__RVOL_MODE=dontcare") in new stack
  137. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:15] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(__ALERT_INFO=)") in new stack
  138. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:16] Set("PJSIP/thinktel-edm-0002138b", "QJOINMSG=custom/call-recording-advisory") in new stack
  139. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:17] Set("PJSIP/thinktel-edm-0002138b", "VQ_JOINMSG=") in new stack
  140. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:18] Set("PJSIP/thinktel-edm-0002138b", "QCANCELMISSED=C") in new stack
  141. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:19] Set("PJSIP/thinktel-edm-0002138b", "QRINGOPTS=r") in new stack
  142. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:20] Set("PJSIP/thinktel-edm-0002138b", "QRETRY=") in new stack
  143. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:21] Set("PJSIP/thinktel-edm-0002138b", "VQ_RETRY=") in new stack
  144. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:22] Set("PJSIP/thinktel-edm-0002138b", "QOPTIONS=tCr") in new stack
  145. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:23] Set("PJSIP/thinktel-edm-0002138b", "VQ_OPTIONS=") in new stack
  146. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:24] Set("PJSIP/thinktel-edm-0002138b", "QGOSUB=") in new stack
  147. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:25] Set("PJSIP/thinktel-edm-0002138b", "VQ_GOSUB=") in new stack
  148. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:26] Set("PJSIP/thinktel-edm-0002138b", "QAGI=") in new stack
  149. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:27] Set("PJSIP/thinktel-edm-0002138b", "VQ_AGI=") in new stack
  150. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:28] Set("PJSIP/thinktel-edm-0002138b", "QRULE=1") in new stack
  151. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:29] Set("PJSIP/thinktel-edm-0002138b", "QRULE=1") in new stack
  152. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:30] Set("PJSIP/thinktel-edm-0002138b", "VQ_RULE=") in new stack
  153. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:31] Set("PJSIP/thinktel-edm-0002138b", "QPOSITION=") in new stack
  154. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:32] Set("PJSIP/thinktel-edm-0002138b", "VQ_POSITION=") in new stack
  155. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:33] Gosub("PJSIP/thinktel-edm-0002138b", "sub-record-check,s,1(q,540,dontcare)") in new stack
  156. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/thinktel-edm-0002138b", "10?initialized") in new stack
  157. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  158. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/thinktel-edm-0002138b", "Recordings initialized") in new stack
  159. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(ARG3=dontcare)") in new stack
  160. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/thinktel-edm-0002138b", "REC_POLICY_MODE_SAVE=") in new stack
  161. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(REC_STATUS=NO)") in new stack
  162. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/thinktel-edm-0002138b", "1?checkaction") in new stack
  163. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  164. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/thinktel-edm-0002138b", "0?sub-record-check,q,1") in new stack
  165. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/thinktel-edm-0002138b", "Generic q Recording Check - 780CALLERX 540") in new stack
  166. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/thinktel-edm-0002138b", "recordcheck,1(dontcare,q,540)") in new stack
  167. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/thinktel-edm-0002138b", "Starting recording check against dontcare") in new stack
  168. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/thinktel-edm-0002138b", "dontcare") in new stack
  169. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  170. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  171. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  172. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:34] Set("PJSIP/thinktel-edm-0002138b", "__CWIGNORE=TRUE") in new stack
  173. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:35] Set("PJSIP/thinktel-edm-0002138b", "__CFIGNORE=TRUE") in new stack
  174. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:36] Set("PJSIP/thinktel-edm-0002138b", "__FORWARD_CONTEXT=block-cf") in new stack
  175. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:37] Set("PJSIP/thinktel-edm-0002138b", "__SIGNORE=TRUE") in new stack
  176. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:38] Set("PJSIP/thinktel-edm-0002138b", "__QC_CONFIRM=0") in new stack
  177. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:39] GotoIf("PJSIP/thinktel-edm-0002138b", "0?QVQANNOUNCE:NOQVQANNOUNCE") in new stack
  178. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (ext-queues,540,44)
  179. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:44] Set("PJSIP/thinktel-edm-0002138b", "VQ_CONFIRMMSG=") in new stack
  180. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:45] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Playback(custom/call-recording-advisory, )") in new stack
  181. [2025-09-03 15:41:39] VERBOSE[538997][C-0000ed2a] file.c: <PJSIP/thinktel-edm-0002138b> Playing 'custom/call-recording-advisory.ulaw' (language 'en')
  182. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:46] QueueLog("PJSIP/thinktel-edm-0002138b", "540,1756935698.213397,NONE,DID,780DIDXXXX") in new stack
  183. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:47] Set("PJSIP/thinktel-edm-0002138b", "QAANNOUNCE=") in new stack
  184. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:48] Set("PJSIP/thinktel-edm-0002138b", "VQ_AANNOUNCE=") in new stack
  185. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:49] Set("PJSIP/thinktel-edm-0002138b", "QMOH=") in new stack
  186. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:50] Set("PJSIP/thinktel-edm-0002138b", "VQ_MOH=") in new stack
  187. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:51] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(__MOHCLASS=)") in new stack
  188. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:52] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(CHANNEL(musicclass)=)") in new stack
  189. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:53] Set("PJSIP/thinktel-edm-0002138b", "QMAXWAIT=60") in new stack
  190. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:54] Set("PJSIP/thinktel-edm-0002138b", "VQ_MAXWAIT=") in new stack
  191. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:55] Set("PJSIP/thinktel-edm-0002138b", "QUEUENUM=540") in new stack
  192. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:56] Set("PJSIP/thinktel-edm-0002138b", "QUEUEJOINTIME=1756935711") in new stack
  193. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:57] Set("PJSIP/thinktel-edm-0002138b", "QMIN_PENALTY=1") in new stack
  194. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:58] Set("PJSIP/thinktel-edm-0002138b", "VQ_MIN_PENALTY=") in new stack
  195. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:59] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(QUEUE_MIN_PENALTY=1)") in new stack
  196. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:60] Set("PJSIP/thinktel-edm-0002138b", "QMAX_PENALTY=") in new stack
  197. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:61] Set("PJSIP/thinktel-edm-0002138b", "VQ_MAX_PENALTY=") in new stack
  198. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:62] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(QUEUE_MAX_PENALTY=)") in new stack
  199. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:63] Set("PJSIP/thinktel-edm-0002138b", "QRAISE_PENALTY=") in new stack
  200. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:64] Set("PJSIP/thinktel-edm-0002138b", "VQ_RAISE_PENALTY=") in new stack
  201. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:65] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(QUEUE_RAISE_PENALTY=)") in new stack
  202. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:66] Set("PJSIP/thinktel-edm-0002138b", "_CALLER_DEST=") in new stack
  203. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:67] Set("PJSIP/thinktel-edm-0002138b", "VQ_CDEST=") in new stack
  204. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:68] Set("PJSIP/thinktel-edm-0002138b", "_AGENT_DEST=") in new stack
  205. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:69] Set("PJSIP/thinktel-edm-0002138b", "VQ_ADEST=") in new stack
  206. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:70] Set("PJSIP/thinktel-edm-0002138b", "CHANNEL(hangup_handler_push)=queueCall-hangup,s,1(540,1756935698.213397,PJSIP/thinktel-edm-0002138b)") in new stack
  207. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:71] Queue("PJSIP/thinktel-edm-0002138b", "540,tCr,,,60,,,1,,") in new stack
  208. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:1] Set("Local/310@from-queue-000087ad;2", "QAGENT=310") in new stack
  209. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/310@from-queue/n
  210. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:2] Set("Local/310@from-queue-000087ad;2", "__FROMQ=true") in new stack
  211. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:3] UserEvent("Local/310@from-queue-000087ad;2", "QueueMemberCallDial,QAGENT:310,UNIQ:1756935711.213404,Queue:540,LinkedID:") in new stack
  212. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:4] Set("Local/310@from-queue-000087ad;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(310,1756935711.213404,540)") in new stack
  213. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:5] GotoIf("Local/310@from-queue-000087ad;2", "0?hangup") in new stack
  214. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue:6] GotoIf("Local/310@from-queue-000087ad;2", "1?540,1:hangup") in new stack
  215. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  216. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/310@from-queue-000087ad;2", "from-queue-exten-internal,310,1") in new stack
  217. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,310,1)
  218. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:1] GotoIf("Local/310@from-queue-000087ad;2", "0?hangup") in new stack
  219. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:2] GotoIf("Local/310@from-queue-000087ad;2", "0?from-queue-exten-only-x,310,1") in new stack
  220. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:3] Set("Local/310@from-queue-000087ad;2", "RingGroupMethod=none") in new stack
  221. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:4] Set("Local/310@from-queue-000087ad;2", "CHANNEL(language)=en") in new stack
  222. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:5] Set("Local/310@from-queue-000087ad;2", "QDOPTS=") in new stack
  223. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:6] Set("Local/310@from-queue-000087ad;2", "CALLTYPE_OVERRIDE=external") in new stack
  224. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:7] ExecIf("Local/310@from-queue-000087ad;2", "1?Set(FROMEXTEN=540)") in new stack
  225. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:8] Gosub("Local/310@from-queue-000087ad;2", "sub-record-check,s,1(exten,310,)") in new stack
  226. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/310@from-queue-000087ad;2", "3?initialized") in new stack
  227. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  228. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/310@from-queue-000087ad;2", "Recordings initialized") in new stack
  229. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/310@from-queue-000087ad;2", "1?Set(ARG3=dontcare)") in new stack
  230. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/310@from-queue-000087ad;2", "REC_POLICY_MODE_SAVE=") in new stack
  231. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/310@from-queue-000087ad;2", "0?Set(REC_STATUS=NO)") in new stack
  232. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/310@from-queue-000087ad;2", "5?checkaction") in new stack
  233. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  234. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/310@from-queue-000087ad;2", "1?sub-record-check,exten,1") in new stack
  235. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  236. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/310@from-queue-000087ad;2", "Exten Recording Check between 540 and 310") in new stack
  237. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/310@from-queue-000087ad;2", "CALLTYPE=external") in new stack
  238. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/310@from-queue-000087ad;2", "8?Set(CALLTYPE=external)") in new stack
  239. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/310@from-queue-000087ad;2", "CALLEE=dontcare") in new stack
  240. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/310@from-queue-000087ad;2", "0?Set(CALLEE=dontcare)") in new stack
  241. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/310@from-queue-000087ad;2", "1?callee") in new stack
  242. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  243. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/310@from-queue-000087ad;2", "recordcheck,1(dontcare,external,310)") in new stack
  244. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/310@from-queue-000087ad;2", "Starting recording check against dontcare") in new stack
  245. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/310@from-queue-000087ad;2", "dontcare") in new stack
  246. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  247. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/310@from-queue-000087ad;2", "") in new stack
  248. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/310@from-queue-000087ad;2", "") in new stack
  249. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:9] Gosub("Local/310@from-queue-000087ad;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),310)") in new stack
  250. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/310@from-queue-000087ad;2", "DEXTEN=310") in new stack
  251. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/310@from-queue-000087ad;2", "__CRM_SOURCE=780CALLERX") in new stack
  252. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/310@from-queue-000087ad;2", "__MCEXTTOCALL=") in new stack
  253. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/310@from-queue-000087ad;2", "__MCMULTI=762a6a259243dc23ea4f189343142313") in new stack
  254. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/310@from-queue-000087ad;2", "1?Set(__EXTTOCALL=310)") in new stack
  255. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/310@from-queue-000087ad;2", "DIALSTATUS_CW=") in new stack
  256. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/310@from-queue-000087ad;2", "0?screen,1()") in new stack
  257. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/310@from-queue-000087ad;2", "0?cf,1()") in new stack
  258. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/310@from-queue-000087ad;2", "1?skip1") in new stack
  259. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  260. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/310@from-queue-000087ad;2", "0?nodial") in new stack
  261. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/310@from-queue-000087ad;2", "0?continue") in new stack
  262. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/310@from-queue-000087ad;2", "EXTHASCW=") in new stack
  263. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/310@from-queue-000087ad;2", "1?next1:cwinusebusy") in new stack
  264. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  265. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/310@from-queue-000087ad;2", "0?docfu:skip3") in new stack
  266. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  267. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/310@from-queue-000087ad;2", "1?next2:continue") in new stack
  268. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  269. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/310@from-queue-000087ad;2", "0?continue") in new stack
  270. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:22] ExecIf("Local/310@from-queue-000087ad;2", "0?Set(DIALSTATUS=BUSY)") in new stack
  271. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:23] GotoIf("Local/310@from-queue-000087ad;2", "0?cwinusebusy") in new stack
  272. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:24] Set("Local/310@from-queue-000087ad;2", "DEXTEN=") in new stack
  273. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:25] Set("Local/310@from-queue-000087ad;2", "DIALSTATUS=BUSY") in new stack
  274. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:26] Goto("Local/310@from-queue-000087ad;2", "nodial") in new stack
  275. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,64)
  276. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:64] NoOp("Local/310@from-queue-000087ad;2", "") in new stack
  277. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:65] ExecIf("Local/310@from-queue-000087ad;2", "0?Set(DIALSTATUS=NOANSWER)") in new stack
  278. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:66] NoOp("Local/310@from-queue-000087ad;2", "Returned from dial-one with nothing to call and DIALSTATUS: BUSY") in new stack
  279. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:67] Return("Local/310@from-queue-000087ad;2", "") in new stack
  280. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:10] GotoIf("Local/310@from-queue-000087ad;2", "0?,,") in new stack
  281. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [310@from-queue-exten-internal:11] Hangup("Local/310@from-queue-000087ad;2", "") in new stack
  282. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Spawn extension (from-queue-exten-internal, 310, 11) exited non-zero on 'Local/310@from-queue-000087ad;2'
  283. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [h@from-queue-exten-internal:1] Gosub("Local/310@from-queue-000087ad;2", "macro-hangupcall,s,1()") in new stack
  284. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/310@from-queue-000087ad;2", "__MCVMSTATUS=") in new stack
  285. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/310@from-queue-000087ad;2", "app-missedcall-hangup,s,1()") in new stack
  286. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/310@from-queue-000087ad;2", "Dialed: s") in new stack
  287. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/310@from-queue-000087ad;2", "Caller: ") in new stack
  288. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/310@from-queue-000087ad;2", "1?exit") in new stack
  289. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  290. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/310@from-queue-000087ad;2", "") in new stack
  291. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/310@from-queue-000087ad;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  292. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/310@from-queue-000087ad;2", "1?theend") in new stack
  293. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  294. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/310@from-queue-000087ad;2", "0?Set(CDR(recordingfile)=)") in new stack
  295. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/310@from-queue-000087ad;2", "") in new stack
  296. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/310@from-queue-000087ad;2'
  297. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] app_stack.c: Local/310@from-queue-000087ad;2 Internal Gosub(queueMemberCall-hangup,s,1(310,1756935711.213404,540)) start
  298. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/310@from-queue-000087ad;2", "310") in new stack
  299. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/310@from-queue-000087ad;2", "QueueMemberCallHangup,QAGENT:310,UNIQ:1756935711.213404,Queue:540,DIALSTATUS:BUSY") in new stack
  300. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/310@from-queue-000087ad;2", "") in new stack
  301. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/310@from-queue-000087ad;2'
  302. [2025-09-03 15:41:51] VERBOSE[539051][C-0000ed2a] app_stack.c: Local/310@from-queue-000087ad;2 Internal Gosub(queueMemberCall-hangup,s,1(310,1756935711.213404,540)) complete GOSUB_RETVAL=
  303. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 0 ms
  304. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:1] Set("Local/306@from-queue-000087ae;2", "QAGENT=306") in new stack
  305. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:2] Set("Local/306@from-queue-000087ae;2", "__FROMQ=true") in new stack
  306. [2025-09-03 15:41:51] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/306@from-queue/n
  307. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:3] UserEvent("Local/306@from-queue-000087ae;2", "QueueMemberCallDial,QAGENT:306,UNIQ:1756935711.213406,Queue:540,LinkedID:") in new stack
  308. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:4] Set("Local/306@from-queue-000087ae;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(306,1756935711.213406,540)") in new stack
  309. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:5] GotoIf("Local/306@from-queue-000087ae;2", "0?hangup") in new stack
  310. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue:6] GotoIf("Local/306@from-queue-000087ae;2", "1?540,1:hangup") in new stack
  311. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  312. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/306@from-queue-000087ae;2", "from-queue-exten-internal,306,1") in new stack
  313. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,306,1)
  314. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:1] GotoIf("Local/306@from-queue-000087ae;2", "0?hangup") in new stack
  315. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:2] GotoIf("Local/306@from-queue-000087ae;2", "0?from-queue-exten-only-x,306,1") in new stack
  316. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:3] Set("Local/306@from-queue-000087ae;2", "RingGroupMethod=none") in new stack
  317. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:4] Set("Local/306@from-queue-000087ae;2", "CHANNEL(language)=en") in new stack
  318. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:5] Set("Local/306@from-queue-000087ae;2", "QDOPTS=") in new stack
  319. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:6] Set("Local/306@from-queue-000087ae;2", "CALLTYPE_OVERRIDE=external") in new stack
  320. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:7] ExecIf("Local/306@from-queue-000087ae;2", "1?Set(FROMEXTEN=540)") in new stack
  321. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:8] Gosub("Local/306@from-queue-000087ae;2", "sub-record-check,s,1(exten,306,)") in new stack
  322. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/306@from-queue-000087ae;2", "3?initialized") in new stack
  323. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  324. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/306@from-queue-000087ae;2", "Recordings initialized") in new stack
  325. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/306@from-queue-000087ae;2", "1?Set(ARG3=dontcare)") in new stack
  326. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/306@from-queue-000087ae;2", "REC_POLICY_MODE_SAVE=") in new stack
  327. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/306@from-queue-000087ae;2", "0?Set(REC_STATUS=NO)") in new stack
  328. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/306@from-queue-000087ae;2", "5?checkaction") in new stack
  329. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  330. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/306@from-queue-000087ae;2", "1?sub-record-check,exten,1") in new stack
  331. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  332. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/306@from-queue-000087ae;2", "Exten Recording Check between 540 and 306") in new stack
  333. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/306@from-queue-000087ae;2", "CALLTYPE=external") in new stack
  334. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/306@from-queue-000087ae;2", "8?Set(CALLTYPE=external)") in new stack
  335. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/306@from-queue-000087ae;2", "CALLEE=dontcare") in new stack
  336. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/306@from-queue-000087ae;2", "0?Set(CALLEE=dontcare)") in new stack
  337. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/306@from-queue-000087ae;2", "1?callee") in new stack
  338. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  339. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/306@from-queue-000087ae;2", "recordcheck,1(dontcare,external,306)") in new stack
  340. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/306@from-queue-000087ae;2", "Starting recording check against dontcare") in new stack
  341. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/306@from-queue-000087ae;2", "dontcare") in new stack
  342. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  343. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/306@from-queue-000087ae;2", "") in new stack
  344. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/306@from-queue-000087ae;2", "") in new stack
  345. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:9] Gosub("Local/306@from-queue-000087ae;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),306)") in new stack
  346. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/306@from-queue-000087ae;2", "DEXTEN=306") in new stack
  347. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/306@from-queue-000087ae;2", "__CRM_SOURCE=780CALLERX") in new stack
  348. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/306@from-queue-000087ae;2", "__MCEXTTOCALL=") in new stack
  349. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/306@from-queue-000087ae;2", "__MCMULTI=10b894635a59b0d99b136ca151dd645a") in new stack
  350. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/306@from-queue-000087ae;2", "1?Set(__EXTTOCALL=306)") in new stack
  351. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/306@from-queue-000087ae;2", "DIALSTATUS_CW=") in new stack
  352. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/306@from-queue-000087ae;2", "0?screen,1()") in new stack
  353. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/306@from-queue-000087ae;2", "0?cf,1()") in new stack
  354. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/306@from-queue-000087ae;2", "1?skip1") in new stack
  355. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  356. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/306@from-queue-000087ae;2", "0?nodial") in new stack
  357. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/306@from-queue-000087ae;2", "0?continue") in new stack
  358. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/306@from-queue-000087ae;2", "EXTHASCW=") in new stack
  359. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/306@from-queue-000087ae;2", "1?next1:cwinusebusy") in new stack
  360. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  361. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/306@from-queue-000087ae;2", "0?docfu:skip3") in new stack
  362. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  363. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/306@from-queue-000087ae;2", "1?next2:continue") in new stack
  364. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  365. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/306@from-queue-000087ae;2", "0?continue") in new stack
  366. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:22] ExecIf("Local/306@from-queue-000087ae;2", "0?Set(DIALSTATUS=BUSY)") in new stack
  367. [2025-09-03 15:41:51] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:23] GotoIf("Local/306@from-queue-000087ae;2", "0?cwinusebusy") in new stack
  368. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:24] Set("Local/306@from-queue-000087ae;2", "DEXTEN=") in new stack
  369. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:25] Set("Local/306@from-queue-000087ae;2", "DIALSTATUS=BUSY") in new stack
  370. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:26] Goto("Local/306@from-queue-000087ae;2", "nodial") in new stack
  371. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,64)
  372. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:64] NoOp("Local/306@from-queue-000087ae;2", "") in new stack
  373. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:65] ExecIf("Local/306@from-queue-000087ae;2", "0?Set(DIALSTATUS=NOANSWER)") in new stack
  374. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:66] NoOp("Local/306@from-queue-000087ae;2", "Returned from dial-one with nothing to call and DIALSTATUS: BUSY") in new stack
  375. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:67] Return("Local/306@from-queue-000087ae;2", "") in new stack
  376. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:10] GotoIf("Local/306@from-queue-000087ae;2", "0?,,") in new stack
  377. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:11] Hangup("Local/306@from-queue-000087ae;2", "") in new stack
  378. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Spawn extension (from-queue-exten-internal, 306, 11) exited non-zero on 'Local/306@from-queue-000087ae;2'
  379. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [h@from-queue-exten-internal:1] Gosub("Local/306@from-queue-000087ae;2", "macro-hangupcall,s,1()") in new stack
  380. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/306@from-queue-000087ae;2", "__MCVMSTATUS=") in new stack
  381. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/306@from-queue-000087ae;2", "app-missedcall-hangup,s,1()") in new stack
  382. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/306@from-queue-000087ae;2", "Dialed: s") in new stack
  383. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/306@from-queue-000087ae;2", "Caller: ") in new stack
  384. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/306@from-queue-000087ae;2", "1?exit") in new stack
  385. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  386. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/306@from-queue-000087ae;2", "") in new stack
  387. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/306@from-queue-000087ae;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  388. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/306@from-queue-000087ae;2", "1?theend") in new stack
  389. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  390. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/306@from-queue-000087ae;2", "0?Set(CDR(recordingfile)=)") in new stack
  391. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/306@from-queue-000087ae;2", "") in new stack
  392. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/306@from-queue-000087ae;2'
  393. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] app_stack.c: Local/306@from-queue-000087ae;2 Internal Gosub(queueMemberCall-hangup,s,1(306,1756935711.213406,540)) start
  394. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/306@from-queue-000087ae;2", "306") in new stack
  395. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/306@from-queue-000087ae;2", "QueueMemberCallHangup,QAGENT:306,UNIQ:1756935711.213406,Queue:540,DIALSTATUS:BUSY") in new stack
  396. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/306@from-queue-000087ae;2", "") in new stack
  397. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/306@from-queue-000087ae;2'
  398. [2025-09-03 15:41:52] VERBOSE[539052][C-0000ed2a] app_stack.c: Local/306@from-queue-000087ae;2 Internal Gosub(queueMemberCall-hangup,s,1(306,1756935711.213406,540)) complete GOSUB_RETVAL=
  399. [2025-09-03 15:41:52] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 1000 ms
  400. [2025-09-03 15:41:52] WARNING[538997][C-0000ed2a] taskprocessor.c: The 'stasis/pool-control' task processor queue reached 500 scheduled tasks again.
  401. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:1] Set("Local/340@from-queue-000087af;2", "QAGENT=340") in new stack
  402. [2025-09-03 15:41:52] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/340@from-queue/n
  403. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:2] Set("Local/340@from-queue-000087af;2", "__FROMQ=true") in new stack
  404. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:3] UserEvent("Local/340@from-queue-000087af;2", "QueueMemberCallDial,QAGENT:340,UNIQ:1756935712.213408,Queue:540,LinkedID:") in new stack
  405. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:4] Set("Local/340@from-queue-000087af;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(340,1756935712.213408,540)") in new stack
  406. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:5] GotoIf("Local/340@from-queue-000087af;2", "0?hangup") in new stack
  407. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue:6] GotoIf("Local/340@from-queue-000087af;2", "1?540,1:hangup") in new stack
  408. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  409. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/340@from-queue-000087af;2", "from-queue-exten-internal,340,1") in new stack
  410. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,340,1)
  411. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:1] GotoIf("Local/340@from-queue-000087af;2", "0?hangup") in new stack
  412. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:2] GotoIf("Local/340@from-queue-000087af;2", "0?from-queue-exten-only-x,340,1") in new stack
  413. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:3] Set("Local/340@from-queue-000087af;2", "RingGroupMethod=none") in new stack
  414. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:4] Set("Local/340@from-queue-000087af;2", "CHANNEL(language)=en") in new stack
  415. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:5] Set("Local/340@from-queue-000087af;2", "QDOPTS=") in new stack
  416. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:6] Set("Local/340@from-queue-000087af;2", "CALLTYPE_OVERRIDE=external") in new stack
  417. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:7] ExecIf("Local/340@from-queue-000087af;2", "1?Set(FROMEXTEN=540)") in new stack
  418. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:8] Gosub("Local/340@from-queue-000087af;2", "sub-record-check,s,1(exten,340,)") in new stack
  419. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/340@from-queue-000087af;2", "3?initialized") in new stack
  420. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  421. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/340@from-queue-000087af;2", "Recordings initialized") in new stack
  422. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/340@from-queue-000087af;2", "1?Set(ARG3=dontcare)") in new stack
  423. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/340@from-queue-000087af;2", "REC_POLICY_MODE_SAVE=") in new stack
  424. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/340@from-queue-000087af;2", "0?Set(REC_STATUS=NO)") in new stack
  425. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/340@from-queue-000087af;2", "5?checkaction") in new stack
  426. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  427. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/340@from-queue-000087af;2", "1?sub-record-check,exten,1") in new stack
  428. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  429. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/340@from-queue-000087af;2", "Exten Recording Check between 540 and 340") in new stack
  430. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/340@from-queue-000087af;2", "CALLTYPE=external") in new stack
  431. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/340@from-queue-000087af;2", "8?Set(CALLTYPE=external)") in new stack
  432. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/340@from-queue-000087af;2", "CALLEE=dontcare") in new stack
  433. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/340@from-queue-000087af;2", "0?Set(CALLEE=dontcare)") in new stack
  434. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/340@from-queue-000087af;2", "1?callee") in new stack
  435. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  436. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/340@from-queue-000087af;2", "recordcheck,1(dontcare,external,340)") in new stack
  437. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/340@from-queue-000087af;2", "Starting recording check against dontcare") in new stack
  438. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/340@from-queue-000087af;2", "dontcare") in new stack
  439. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  440. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/340@from-queue-000087af;2", "") in new stack
  441. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/340@from-queue-000087af;2", "") in new stack
  442. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:9] Gosub("Local/340@from-queue-000087af;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),340)") in new stack
  443. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/340@from-queue-000087af;2", "DEXTEN=340") in new stack
  444. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/340@from-queue-000087af;2", "__CRM_SOURCE=780CALLERX") in new stack
  445. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/340@from-queue-000087af;2", "__MCEXTTOCALL=") in new stack
  446. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/340@from-queue-000087af;2", "__MCMULTI=5633a950a4bfbecc7eba029fcae3b10b") in new stack
  447. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/340@from-queue-000087af;2", "1?Set(__EXTTOCALL=340)") in new stack
  448. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/340@from-queue-000087af;2", "DIALSTATUS_CW=") in new stack
  449. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/340@from-queue-000087af;2", "0?screen,1()") in new stack
  450. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/340@from-queue-000087af;2", "0?cf,1()") in new stack
  451. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/340@from-queue-000087af;2", "1?skip1") in new stack
  452. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  453. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/340@from-queue-000087af;2", "0?nodial") in new stack
  454. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/340@from-queue-000087af;2", "0?continue") in new stack
  455. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/340@from-queue-000087af;2", "EXTHASCW=") in new stack
  456. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/340@from-queue-000087af;2", "1?next1:cwinusebusy") in new stack
  457. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  458. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/340@from-queue-000087af;2", "0?docfu:skip3") in new stack
  459. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  460. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/340@from-queue-000087af;2", "1?next2:continue") in new stack
  461. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  462. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/340@from-queue-000087af;2", "1?continue") in new stack
  463. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,29)
  464. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:29] GotoIf("Local/340@from-queue-000087af;2", "0?nodial") in new stack
  465. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:30] GosubIf("Local/340@from-queue-000087af;2", "1?dstring,1():dlocal,1()") in new stack
  466. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:1] Set("Local/340@from-queue-000087af;2", "DSTRING=") in new stack
  467. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:2] Set("Local/340@from-queue-000087af;2", "DEVICES=340") in new stack
  468. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("Local/340@from-queue-000087af;2", "0?Return()") in new stack
  469. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("Local/340@from-queue-000087af;2", "0?Set(DEVICES=40)") in new stack
  470. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:5] Set("Local/340@from-queue-000087af;2", "LOOPCNT=1") in new stack
  471. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:6] Set("Local/340@from-queue-000087af;2", "ITER=1") in new stack
  472. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:7] Set("Local/340@from-queue-000087af;2", "THISDIAL=PJSIP/340") in new stack
  473. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("Local/340@from-queue-000087af;2", "0?docheck") in new stack
  474. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("Local/340@from-queue-000087af;2", "Debug: Found PJSIP Destination PJSIP/340") in new stack
  475. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("Local/340@from-queue-000087af;2", "0?doset") in new stack
  476. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("Local/340@from-queue-000087af;2", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
  477. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:12] Set("Local/340@from-queue-000087af;2", "THISDIAL=PJSIP/340/sip:[email protected]:5060") in new stack
  478. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("Local/340@from-queue-000087af;2", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
  479. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("Local/340@from-queue-000087af;2", "0?skipset") in new stack
  480. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:15] Set("Local/340@from-queue-000087af;2", "DSTRING=PJSIP/340/sip:[email protected]:5060&") in new stack
  481. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:16] Set("Local/340@from-queue-000087af;2", "ITER=2") in new stack
  482. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("Local/340@from-queue-000087af;2", "0?begin") in new stack
  483. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("Local/340@from-queue-000087af;2", "0?Return()") in new stack
  484. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:19] Set("Local/340@from-queue-000087af;2", "DSTRING=PJSIP/340/sip:[email protected]:5060") in new stack
  485. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:20] Return("Local/340@from-queue-000087af;2", "") in new stack
  486. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:31] GotoIf("Local/340@from-queue-000087af;2", "0?nodial") in new stack
  487. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:32] GotoIf("Local/340@from-queue-000087af;2", "0?skiptrace") in new stack
  488. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:33] GosubIf("Local/340@from-queue-000087af;2", "1?ctset,1():ctclear,1()") in new stack
  489. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:1] Set("Local/340@from-queue-000087af;2", "DB(CALLTRACE/340)=780CALLERX") in new stack
  490. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:2] Return("Local/340@from-queue-000087af;2", "") in new stack
  491. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:34] Set("Local/340@from-queue-000087af;2", "D_OPTIONS=HhTtrU(macro-auto-blkvm)") in new stack
  492. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:35] GosubIf("Local/340@from-queue-000087af;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  493. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:36] NoOp("Local/340@from-queue-000087af;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  494. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:37] ExecIf("Local/340@from-queue-000087af;2", "0?Set(ALERT_INFO=)") in new stack
  495. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:38] ExecIf("Local/340@from-queue-000087af;2", "0?Set(ALERT_INFO=)") in new stack
  496. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:39] ExecIf("Local/340@from-queue-000087af;2", "0?Set(ALERT_INFO=)") in new stack
  497. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:40] ExecIf("Local/340@from-queue-000087af;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  498. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:41] ExecIf("Local/340@from-queue-000087af;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  499. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:42] GosubIf("Local/340@from-queue-000087af;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  500. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:43] ExecIf("Local/340@from-queue-000087af;2", "0?Set(CHANNEL(musicclass)=)") in new stack
  501. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:44] GosubIf("Local/340@from-queue-000087af;2", "0?qwait,1()") in new stack
  502. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:45] Set("Local/340@from-queue-000087af;2", "__CWIGNORE=TRUE") in new stack
  503. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:46] Set("Local/340@from-queue-000087af;2", "__KEEPCID=TRUE") in new stack
  504. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:47] GotoIf("Local/340@from-queue-000087af;2", "0?usegoto,1") in new stack
  505. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:48] GotoIf("Local/340@from-queue-000087af;2", "1?godial") in new stack
  506. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,53)
  507. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:53] Gosub("Local/340@from-queue-000087af;2", "macro-dialout-one-predial-hook,s,1()") in new stack
  508. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] Return("Local/340@from-queue-000087af;2", "") in new stack
  509. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:54] ExecIf("Local/340@from-queue-000087af;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  510. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:55] ExecIf("Local/340@from-queue-000087af;2", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
  511. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:56] NoOp("Local/340@from-queue-000087af;2", "") in new stack
  512. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:57] ExecIf("Local/340@from-queue-000087af;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  513. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:58] ExecIf("Local/340@from-queue-000087af;2", "0?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)Ig)") in new stack
  514. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:59] Gosub("Local/340@from-queue-000087af;2", "dialOne-with-exten,340,1()") in new stack
  515. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:1] Set("Local/340@from-queue-000087af;2", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,,1") in new stack
  516. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:2] Dial("Local/340@from-queue-000087af;2", "PJSIP/340/sip:[email protected]:5060,,HhtrU(macro-auto-blkvm)Ib(func-apply-sipheaders^s^1)") in new stack
  517. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(func-apply-sipheaders,s,1) start
  518. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/340-0002138d", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  519. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/340-0002138d", "Applying SIP Headers to channel PJSIP/340-0002138d") in new stack
  520. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/340-0002138d", "localchan=340-0002138d") in new stack
  521. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/340-0002138d", "DialMCEXT=340") in new stack
  522. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:5] Set("PJSIP/340-0002138d", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,340,1") in new stack
  523. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:6] Set("PJSIP/340-0002138d", "Dchan=340-0002138d") in new stack
  524. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:7] Set("PJSIP/340-0002138d", "TECH=PJSIP") in new stack
  525. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:8] Set("PJSIP/340-0002138d", "SIPHEADERKEYS=") in new stack
  526. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:9] While("PJSIP/340-0002138d", "0") in new stack
  527. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_while.c: Jumping to priority 15
  528. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:16] Return("PJSIP/340-0002138d", "") in new stack
  529. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-0002138d'
  530. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  531. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_dial.c: Called PJSIP/340/sip:[email protected]:5060
  532. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_dial.c: Connected line update to Local/340@from-queue-000087af;2 prevented.
  533. [2025-09-03 15:41:52] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087af;1 is ringing
  534. [2025-09-03 15:41:52] VERBOSE[539053][C-0000ed2a] app_dial.c: PJSIP/340-0002138d is ringing
  535. [2025-09-03 15:41:52] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087af;1 is ringing
  536. [2025-09-03 15:42:10] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 19000 ms
  537. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(app-missedcall-hangup,340,1) start
  538. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("PJSIP/340-0002138d", "Dialed: 340") in new stack
  539. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("PJSIP/340-0002138d", "Caller: ") in new stack
  540. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("PJSIP/340-0002138d", "0?exit") in new stack
  541. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("PJSIP/340-0002138d", "EXTENNUM=340") in new stack
  542. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("PJSIP/340-0002138d", "FEXTENNUM=340") in new stack
  543. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("PJSIP/340-0002138d", "0?exit") in new stack
  544. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("PJSIP/340-0002138d", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,PJSIP/340-0002138d,,540,,") in new stack
  545. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] res_agi.c: <PJSIP/340-0002138d>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  546. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("PJSIP/340-0002138d", "") in new stack
  547. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-0002138d'
  548. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  549. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(crm-hangup,s,1) start
  550. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/340-0002138d", "Sending Hangup to CRM") in new stack
  551. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/340-0002138d", "HANGUP CAUSE: 26") in new stack
  552. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/340-0002138d", "0?Set(__CRM_VOICEMAIL=)") in new stack
  553. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/340-0002138d", "MASTER CHANNEL: 1756935712.213409 = 1756935698.213397") in new stack
  554. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/340-0002138d", "1?return") in new stack
  555. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (crm-hangup,s,8)
  556. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/340-0002138d", "") in new stack
  557. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-0002138d'
  558. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] app_stack.c: PJSIP/340-0002138d Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  559. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Spawn extension (dialOne-with-exten, 340, 2) exited non-zero on 'Local/340@from-queue-000087af;2'
  560. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [h@dialOne-with-exten:1] Gosub("Local/340@from-queue-000087af;2", "macro-hangupcall,s,1()") in new stack
  561. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/340@from-queue-000087af;2", "__MCVMSTATUS=") in new stack
  562. [2025-09-03 15:42:10] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/340@from-queue-000087af;2", "app-missedcall-hangup,s,1()") in new stack
  563. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087af;2", "Dialed: s") in new stack
  564. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087af;2", "Caller: ") in new stack
  565. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087af;2", "1?exit") in new stack
  566. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  567. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/340@from-queue-000087af;2", "") in new stack
  568. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/340@from-queue-000087af;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  569. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/340@from-queue-000087af;2", "1?theend") in new stack
  570. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  571. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/340@from-queue-000087af;2", "0?Set(CDR(recordingfile)=)") in new stack
  572. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/340@from-queue-000087af;2", "") in new stack
  573. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087af;2'
  574. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Local/340@from-queue-000087af;2 Internal Gosub(app-missedcall-hangup,340,1) start
  575. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087af;2", "Dialed: 340") in new stack
  576. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087af;2", "Caller: ") in new stack
  577. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087af;2", "0?exit") in new stack
  578. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("Local/340@from-queue-000087af;2", "EXTENNUM=340") in new stack
  579. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("Local/340@from-queue-000087af;2", "FEXTENNUM=340") in new stack
  580. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("Local/340@from-queue-000087af;2", "0?exit") in new stack
  581. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("Local/340@from-queue-000087af;2", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,Local/340@from-queue-000087af;2,CANCEL,540,,") in new stack
  582. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] res_agi.c: <Local/340@from-queue-000087af;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  583. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("Local/340@from-queue-000087af;2", "") in new stack
  584. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087af;2'
  585. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Local/340@from-queue-000087af;2 Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  586. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Local/340@from-queue-000087af;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935712.213408,540)) start
  587. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/340@from-queue-000087af;2", "340") in new stack
  588. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/340@from-queue-000087af;2", "QueueMemberCallHangup,QAGENT:340,UNIQ:1756935712.213408,Queue:540,DIALSTATUS:CANCEL") in new stack
  589. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/340@from-queue-000087af;2", "") in new stack
  590. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087af;2'
  591. [2025-09-03 15:42:11] VERBOSE[539053][C-0000ed2a] app_stack.c: Local/340@from-queue-000087af;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935712.213408,540)) complete GOSUB_RETVAL=
  592. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:1] Set("Local/306@from-queue-000087b0;2", "QAGENT=306") in new stack
  593. [2025-09-03 15:42:11] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/306@from-queue/n
  594. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:2] Set("Local/306@from-queue-000087b0;2", "__FROMQ=true") in new stack
  595. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:3] UserEvent("Local/306@from-queue-000087b0;2", "QueueMemberCallDial,QAGENT:306,UNIQ:1756935731.213413,Queue:540,LinkedID:") in new stack
  596. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:4] Set("Local/306@from-queue-000087b0;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(306,1756935731.213413,540)") in new stack
  597. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:5] GotoIf("Local/306@from-queue-000087b0;2", "0?hangup") in new stack
  598. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue:6] GotoIf("Local/306@from-queue-000087b0;2", "1?540,1:hangup") in new stack
  599. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  600. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/306@from-queue-000087b0;2", "from-queue-exten-internal,306,1") in new stack
  601. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,306,1)
  602. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:1] GotoIf("Local/306@from-queue-000087b0;2", "0?hangup") in new stack
  603. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:2] GotoIf("Local/306@from-queue-000087b0;2", "0?from-queue-exten-only-x,306,1") in new stack
  604. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:3] Set("Local/306@from-queue-000087b0;2", "RingGroupMethod=none") in new stack
  605. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:4] Set("Local/306@from-queue-000087b0;2", "CHANNEL(language)=en") in new stack
  606. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:5] Set("Local/306@from-queue-000087b0;2", "QDOPTS=") in new stack
  607. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:6] Set("Local/306@from-queue-000087b0;2", "CALLTYPE_OVERRIDE=external") in new stack
  608. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:7] ExecIf("Local/306@from-queue-000087b0;2", "1?Set(FROMEXTEN=540)") in new stack
  609. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:8] Gosub("Local/306@from-queue-000087b0;2", "sub-record-check,s,1(exten,306,)") in new stack
  610. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/306@from-queue-000087b0;2", "3?initialized") in new stack
  611. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  612. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/306@from-queue-000087b0;2", "Recordings initialized") in new stack
  613. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/306@from-queue-000087b0;2", "1?Set(ARG3=dontcare)") in new stack
  614. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/306@from-queue-000087b0;2", "REC_POLICY_MODE_SAVE=") in new stack
  615. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/306@from-queue-000087b0;2", "0?Set(REC_STATUS=NO)") in new stack
  616. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/306@from-queue-000087b0;2", "5?checkaction") in new stack
  617. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  618. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/306@from-queue-000087b0;2", "1?sub-record-check,exten,1") in new stack
  619. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  620. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/306@from-queue-000087b0;2", "Exten Recording Check between 540 and 306") in new stack
  621. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/306@from-queue-000087b0;2", "CALLTYPE=external") in new stack
  622. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/306@from-queue-000087b0;2", "8?Set(CALLTYPE=external)") in new stack
  623. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/306@from-queue-000087b0;2", "CALLEE=dontcare") in new stack
  624. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/306@from-queue-000087b0;2", "0?Set(CALLEE=dontcare)") in new stack
  625. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/306@from-queue-000087b0;2", "1?callee") in new stack
  626. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  627. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/306@from-queue-000087b0;2", "recordcheck,1(dontcare,external,306)") in new stack
  628. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/306@from-queue-000087b0;2", "Starting recording check against dontcare") in new stack
  629. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/306@from-queue-000087b0;2", "dontcare") in new stack
  630. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  631. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/306@from-queue-000087b0;2", "") in new stack
  632. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/306@from-queue-000087b0;2", "") in new stack
  633. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:9] Gosub("Local/306@from-queue-000087b0;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),306)") in new stack
  634. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/306@from-queue-000087b0;2", "DEXTEN=306") in new stack
  635. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/306@from-queue-000087b0;2", "__CRM_SOURCE=780CALLERX") in new stack
  636. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/306@from-queue-000087b0;2", "__MCEXTTOCALL=") in new stack
  637. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/306@from-queue-000087b0;2", "__MCMULTI=10b894635a59b0d99b136ca151dd645a") in new stack
  638. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/306@from-queue-000087b0;2", "1?Set(__EXTTOCALL=306)") in new stack
  639. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/306@from-queue-000087b0;2", "DIALSTATUS_CW=") in new stack
  640. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/306@from-queue-000087b0;2", "0?screen,1()") in new stack
  641. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/306@from-queue-000087b0;2", "0?cf,1()") in new stack
  642. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/306@from-queue-000087b0;2", "1?skip1") in new stack
  643. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  644. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/306@from-queue-000087b0;2", "0?nodial") in new stack
  645. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/306@from-queue-000087b0;2", "0?continue") in new stack
  646. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/306@from-queue-000087b0;2", "EXTHASCW=") in new stack
  647. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/306@from-queue-000087b0;2", "1?next1:cwinusebusy") in new stack
  648. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  649. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/306@from-queue-000087b0;2", "0?docfu:skip3") in new stack
  650. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  651. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/306@from-queue-000087b0;2", "1?next2:continue") in new stack
  652. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  653. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/306@from-queue-000087b0;2", "0?continue") in new stack
  654. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:22] ExecIf("Local/306@from-queue-000087b0;2", "0?Set(DIALSTATUS=BUSY)") in new stack
  655. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:23] GotoIf("Local/306@from-queue-000087b0;2", "0?cwinusebusy") in new stack
  656. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:24] Set("Local/306@from-queue-000087b0;2", "DEXTEN=") in new stack
  657. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:25] Set("Local/306@from-queue-000087b0;2", "DIALSTATUS=BUSY") in new stack
  658. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:26] Goto("Local/306@from-queue-000087b0;2", "nodial") in new stack
  659. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,64)
  660. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:64] NoOp("Local/306@from-queue-000087b0;2", "") in new stack
  661. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:65] ExecIf("Local/306@from-queue-000087b0;2", "0?Set(DIALSTATUS=NOANSWER)") in new stack
  662. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:66] NoOp("Local/306@from-queue-000087b0;2", "Returned from dial-one with nothing to call and DIALSTATUS: BUSY") in new stack
  663. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:67] Return("Local/306@from-queue-000087b0;2", "") in new stack
  664. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:10] GotoIf("Local/306@from-queue-000087b0;2", "0?,,") in new stack
  665. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [306@from-queue-exten-internal:11] Hangup("Local/306@from-queue-000087b0;2", "") in new stack
  666. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Spawn extension (from-queue-exten-internal, 306, 11) exited non-zero on 'Local/306@from-queue-000087b0;2'
  667. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [h@from-queue-exten-internal:1] Gosub("Local/306@from-queue-000087b0;2", "macro-hangupcall,s,1()") in new stack
  668. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/306@from-queue-000087b0;2", "__MCVMSTATUS=") in new stack
  669. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/306@from-queue-000087b0;2", "app-missedcall-hangup,s,1()") in new stack
  670. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/306@from-queue-000087b0;2", "Dialed: s") in new stack
  671. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/306@from-queue-000087b0;2", "Caller: ") in new stack
  672. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/306@from-queue-000087b0;2", "1?exit") in new stack
  673. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  674. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/306@from-queue-000087b0;2", "") in new stack
  675. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/306@from-queue-000087b0;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  676. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/306@from-queue-000087b0;2", "1?theend") in new stack
  677. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  678. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/306@from-queue-000087b0;2", "0?Set(CDR(recordingfile)=)") in new stack
  679. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/306@from-queue-000087b0;2", "") in new stack
  680. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/306@from-queue-000087b0;2'
  681. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] app_stack.c: Local/306@from-queue-000087b0;2 Internal Gosub(queueMemberCall-hangup,s,1(306,1756935731.213413,540)) start
  682. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/306@from-queue-000087b0;2", "306") in new stack
  683. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/306@from-queue-000087b0;2", "QueueMemberCallHangup,QAGENT:306,UNIQ:1756935731.213413,Queue:540,DIALSTATUS:BUSY") in new stack
  684. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/306@from-queue-000087b0;2", "") in new stack
  685. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/306@from-queue-000087b0;2'
  686. [2025-09-03 15:42:11] VERBOSE[539258][C-0000ed2a] app_stack.c: Local/306@from-queue-000087b0;2 Internal Gosub(queueMemberCall-hangup,s,1(306,1756935731.213413,540)) complete GOSUB_RETVAL=
  687. [2025-09-03 15:42:11] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 0 ms
  688. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:1] Set("Local/340@from-queue-000087b1;2", "QAGENT=340") in new stack
  689. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:2] Set("Local/340@from-queue-000087b1;2", "__FROMQ=true") in new stack
  690. [2025-09-03 15:42:11] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/340@from-queue/n
  691. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:3] UserEvent("Local/340@from-queue-000087b1;2", "QueueMemberCallDial,QAGENT:340,UNIQ:1756935731.213415,Queue:540,LinkedID:") in new stack
  692. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:4] Set("Local/340@from-queue-000087b1;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(340,1756935731.213415,540)") in new stack
  693. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:5] GotoIf("Local/340@from-queue-000087b1;2", "0?hangup") in new stack
  694. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue:6] GotoIf("Local/340@from-queue-000087b1;2", "1?540,1:hangup") in new stack
  695. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  696. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/340@from-queue-000087b1;2", "from-queue-exten-internal,340,1") in new stack
  697. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,340,1)
  698. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:1] GotoIf("Local/340@from-queue-000087b1;2", "0?hangup") in new stack
  699. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:2] GotoIf("Local/340@from-queue-000087b1;2", "0?from-queue-exten-only-x,340,1") in new stack
  700. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:3] Set("Local/340@from-queue-000087b1;2", "RingGroupMethod=none") in new stack
  701. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:4] Set("Local/340@from-queue-000087b1;2", "CHANNEL(language)=en") in new stack
  702. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:5] Set("Local/340@from-queue-000087b1;2", "QDOPTS=") in new stack
  703. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:6] Set("Local/340@from-queue-000087b1;2", "CALLTYPE_OVERRIDE=external") in new stack
  704. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:7] ExecIf("Local/340@from-queue-000087b1;2", "1?Set(FROMEXTEN=540)") in new stack
  705. [2025-09-03 15:42:11] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:8] Gosub("Local/340@from-queue-000087b1;2", "sub-record-check,s,1(exten,340,)") in new stack
  706. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/340@from-queue-000087b1;2", "3?initialized") in new stack
  707. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  708. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/340@from-queue-000087b1;2", "Recordings initialized") in new stack
  709. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/340@from-queue-000087b1;2", "1?Set(ARG3=dontcare)") in new stack
  710. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/340@from-queue-000087b1;2", "REC_POLICY_MODE_SAVE=") in new stack
  711. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(REC_STATUS=NO)") in new stack
  712. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/340@from-queue-000087b1;2", "5?checkaction") in new stack
  713. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  714. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/340@from-queue-000087b1;2", "1?sub-record-check,exten,1") in new stack
  715. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  716. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/340@from-queue-000087b1;2", "Exten Recording Check between 540 and 340") in new stack
  717. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/340@from-queue-000087b1;2", "CALLTYPE=external") in new stack
  718. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/340@from-queue-000087b1;2", "8?Set(CALLTYPE=external)") in new stack
  719. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/340@from-queue-000087b1;2", "CALLEE=dontcare") in new stack
  720. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(CALLEE=dontcare)") in new stack
  721. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/340@from-queue-000087b1;2", "1?callee") in new stack
  722. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  723. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/340@from-queue-000087b1;2", "recordcheck,1(dontcare,external,340)") in new stack
  724. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/340@from-queue-000087b1;2", "Starting recording check against dontcare") in new stack
  725. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/340@from-queue-000087b1;2", "dontcare") in new stack
  726. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  727. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/340@from-queue-000087b1;2", "") in new stack
  728. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/340@from-queue-000087b1;2", "") in new stack
  729. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:9] Gosub("Local/340@from-queue-000087b1;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),340)") in new stack
  730. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/340@from-queue-000087b1;2", "DEXTEN=340") in new stack
  731. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/340@from-queue-000087b1;2", "__CRM_SOURCE=780CALLERX") in new stack
  732. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/340@from-queue-000087b1;2", "__MCEXTTOCALL=") in new stack
  733. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/340@from-queue-000087b1;2", "__MCMULTI=5633a950a4bfbecc7eba029fcae3b10b") in new stack
  734. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/340@from-queue-000087b1;2", "1?Set(__EXTTOCALL=340)") in new stack
  735. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/340@from-queue-000087b1;2", "DIALSTATUS_CW=") in new stack
  736. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/340@from-queue-000087b1;2", "0?screen,1()") in new stack
  737. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/340@from-queue-000087b1;2", "0?cf,1()") in new stack
  738. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/340@from-queue-000087b1;2", "1?skip1") in new stack
  739. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  740. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/340@from-queue-000087b1;2", "0?nodial") in new stack
  741. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/340@from-queue-000087b1;2", "0?continue") in new stack
  742. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/340@from-queue-000087b1;2", "EXTHASCW=") in new stack
  743. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/340@from-queue-000087b1;2", "1?next1:cwinusebusy") in new stack
  744. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  745. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/340@from-queue-000087b1;2", "0?docfu:skip3") in new stack
  746. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  747. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/340@from-queue-000087b1;2", "1?next2:continue") in new stack
  748. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  749. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/340@from-queue-000087b1;2", "1?continue") in new stack
  750. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,29)
  751. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:29] GotoIf("Local/340@from-queue-000087b1;2", "0?nodial") in new stack
  752. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:30] GosubIf("Local/340@from-queue-000087b1;2", "1?dstring,1():dlocal,1()") in new stack
  753. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:1] Set("Local/340@from-queue-000087b1;2", "DSTRING=") in new stack
  754. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:2] Set("Local/340@from-queue-000087b1;2", "DEVICES=340") in new stack
  755. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("Local/340@from-queue-000087b1;2", "0?Return()") in new stack
  756. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(DEVICES=40)") in new stack
  757. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:5] Set("Local/340@from-queue-000087b1;2", "LOOPCNT=1") in new stack
  758. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:6] Set("Local/340@from-queue-000087b1;2", "ITER=1") in new stack
  759. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:7] Set("Local/340@from-queue-000087b1;2", "THISDIAL=PJSIP/340") in new stack
  760. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("Local/340@from-queue-000087b1;2", "0?docheck") in new stack
  761. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("Local/340@from-queue-000087b1;2", "Debug: Found PJSIP Destination PJSIP/340") in new stack
  762. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("Local/340@from-queue-000087b1;2", "0?doset") in new stack
  763. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("Local/340@from-queue-000087b1;2", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
  764. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:12] Set("Local/340@from-queue-000087b1;2", "THISDIAL=PJSIP/340/sip:[email protected]:5060") in new stack
  765. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
  766. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("Local/340@from-queue-000087b1;2", "0?skipset") in new stack
  767. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:15] Set("Local/340@from-queue-000087b1;2", "DSTRING=PJSIP/340/sip:[email protected]:5060&") in new stack
  768. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:16] Set("Local/340@from-queue-000087b1;2", "ITER=2") in new stack
  769. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("Local/340@from-queue-000087b1;2", "0?begin") in new stack
  770. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("Local/340@from-queue-000087b1;2", "0?Return()") in new stack
  771. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:19] Set("Local/340@from-queue-000087b1;2", "DSTRING=PJSIP/340/sip:[email protected]:5060") in new stack
  772. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:20] Return("Local/340@from-queue-000087b1;2", "") in new stack
  773. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:31] GotoIf("Local/340@from-queue-000087b1;2", "0?nodial") in new stack
  774. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:32] GotoIf("Local/340@from-queue-000087b1;2", "0?skiptrace") in new stack
  775. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:33] GosubIf("Local/340@from-queue-000087b1;2", "1?ctset,1():ctclear,1()") in new stack
  776. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:1] Set("Local/340@from-queue-000087b1;2", "DB(CALLTRACE/340)=780CALLERX") in new stack
  777. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:2] Return("Local/340@from-queue-000087b1;2", "") in new stack
  778. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:34] Set("Local/340@from-queue-000087b1;2", "D_OPTIONS=HhTtrU(macro-auto-blkvm)") in new stack
  779. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:35] GosubIf("Local/340@from-queue-000087b1;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  780. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:36] NoOp("Local/340@from-queue-000087b1;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  781. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:37] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(ALERT_INFO=)") in new stack
  782. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:38] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(ALERT_INFO=)") in new stack
  783. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:39] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(ALERT_INFO=)") in new stack
  784. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:40] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  785. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:41] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  786. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:42] GosubIf("Local/340@from-queue-000087b1;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  787. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:43] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(CHANNEL(musicclass)=)") in new stack
  788. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:44] GosubIf("Local/340@from-queue-000087b1;2", "0?qwait,1()") in new stack
  789. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:45] Set("Local/340@from-queue-000087b1;2", "__CWIGNORE=TRUE") in new stack
  790. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:46] Set("Local/340@from-queue-000087b1;2", "__KEEPCID=TRUE") in new stack
  791. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:47] GotoIf("Local/340@from-queue-000087b1;2", "0?usegoto,1") in new stack
  792. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:48] GotoIf("Local/340@from-queue-000087b1;2", "1?godial") in new stack
  793. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,53)
  794. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:53] Gosub("Local/340@from-queue-000087b1;2", "macro-dialout-one-predial-hook,s,1()") in new stack
  795. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] Return("Local/340@from-queue-000087b1;2", "") in new stack
  796. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:54] ExecIf("Local/340@from-queue-000087b1;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  797. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:55] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
  798. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:56] NoOp("Local/340@from-queue-000087b1;2", "") in new stack
  799. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:57] ExecIf("Local/340@from-queue-000087b1;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  800. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:58] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)Ig)") in new stack
  801. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:59] Gosub("Local/340@from-queue-000087b1;2", "dialOne-with-exten,340,1()") in new stack
  802. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:1] Set("Local/340@from-queue-000087b1;2", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,,1") in new stack
  803. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:2] Dial("Local/340@from-queue-000087b1;2", "PJSIP/340/sip:[email protected]:5060,,HhtrU(macro-auto-blkvm)Ib(func-apply-sipheaders^s^1)") in new stack
  804. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(func-apply-sipheaders,s,1) start
  805. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/340-00021390", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  806. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/340-00021390", "Applying SIP Headers to channel PJSIP/340-00021390") in new stack
  807. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/340-00021390", "localchan=340-00021390") in new stack
  808. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/340-00021390", "DialMCEXT=340") in new stack
  809. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:5] Set("PJSIP/340-00021390", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,340,1") in new stack
  810. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:6] Set("PJSIP/340-00021390", "Dchan=340-00021390") in new stack
  811. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:7] Set("PJSIP/340-00021390", "TECH=PJSIP") in new stack
  812. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:8] Set("PJSIP/340-00021390", "SIPHEADERKEYS=") in new stack
  813. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:9] While("PJSIP/340-00021390", "0") in new stack
  814. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_while.c: Jumping to priority 15
  815. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:16] Return("PJSIP/340-00021390", "") in new stack
  816. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021390'
  817. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  818. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_dial.c: Called PJSIP/340/sip:[email protected]:5060
  819. [2025-09-03 15:42:12] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087b1;1 is ringing
  820. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_dial.c: Connected line update to Local/340@from-queue-000087b1;2 prevented.
  821. [2025-09-03 15:42:12] VERBOSE[539259][C-0000ed2a] app_dial.c: PJSIP/340-00021390 is ringing
  822. [2025-09-03 15:42:12] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087b1;1 is ringing
  823. [2025-09-03 15:42:30] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 19000 ms
  824. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(app-missedcall-hangup,340,1) start
  825. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("PJSIP/340-00021390", "Dialed: 340") in new stack
  826. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("PJSIP/340-00021390", "Caller: ") in new stack
  827. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("PJSIP/340-00021390", "0?exit") in new stack
  828. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("PJSIP/340-00021390", "EXTENNUM=340") in new stack
  829. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("PJSIP/340-00021390", "FEXTENNUM=340") in new stack
  830. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("PJSIP/340-00021390", "0?exit") in new stack
  831. [2025-09-03 15:42:30] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("PJSIP/340-00021390", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,PJSIP/340-00021390,,540,,") in new stack
  832. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] res_agi.c: <PJSIP/340-00021390>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  833. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("PJSIP/340-00021390", "") in new stack
  834. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021390'
  835. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  836. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(crm-hangup,s,1) start
  837. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/340-00021390", "Sending Hangup to CRM") in new stack
  838. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/340-00021390", "HANGUP CAUSE: 26") in new stack
  839. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/340-00021390", "0?Set(__CRM_VOICEMAIL=)") in new stack
  840. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/340-00021390", "MASTER CHANNEL: 1756935732.213416 = 1756935698.213397") in new stack
  841. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/340-00021390", "1?return") in new stack
  842. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (crm-hangup,s,8)
  843. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/340-00021390", "") in new stack
  844. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021390'
  845. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: PJSIP/340-00021390 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  846. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Spawn extension (dialOne-with-exten, 340, 2) exited non-zero on 'Local/340@from-queue-000087b1;2'
  847. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [h@dialOne-with-exten:1] Gosub("Local/340@from-queue-000087b1;2", "macro-hangupcall,s,1()") in new stack
  848. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/340@from-queue-000087b1;2", "__MCVMSTATUS=") in new stack
  849. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/340@from-queue-000087b1;2", "app-missedcall-hangup,s,1()") in new stack
  850. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087b1;2", "Dialed: s") in new stack
  851. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087b1;2", "Caller: ") in new stack
  852. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087b1;2", "1?exit") in new stack
  853. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  854. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/340@from-queue-000087b1;2", "") in new stack
  855. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/340@from-queue-000087b1;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  856. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/340@from-queue-000087b1;2", "1?theend") in new stack
  857. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  858. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/340@from-queue-000087b1;2", "0?Set(CDR(recordingfile)=)") in new stack
  859. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/340@from-queue-000087b1;2", "") in new stack
  860. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b1;2'
  861. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b1;2 Internal Gosub(app-missedcall-hangup,340,1) start
  862. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087b1;2", "Dialed: 340") in new stack
  863. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087b1;2", "Caller: ") in new stack
  864. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087b1;2", "0?exit") in new stack
  865. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("Local/340@from-queue-000087b1;2", "EXTENNUM=340") in new stack
  866. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("Local/340@from-queue-000087b1;2", "FEXTENNUM=340") in new stack
  867. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("Local/340@from-queue-000087b1;2", "0?exit") in new stack
  868. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("Local/340@from-queue-000087b1;2", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,Local/340@from-queue-000087b1;2,CANCEL,540,,") in new stack
  869. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] res_agi.c: <Local/340@from-queue-000087b1;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  870. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("Local/340@from-queue-000087b1;2", "") in new stack
  871. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b1;2'
  872. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b1;2 Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  873. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b1;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935731.213415,540)) start
  874. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/340@from-queue-000087b1;2", "340") in new stack
  875. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/340@from-queue-000087b1;2", "QueueMemberCallHangup,QAGENT:340,UNIQ:1756935731.213415,Queue:540,DIALSTATUS:CANCEL") in new stack
  876. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/340@from-queue-000087b1;2", "") in new stack
  877. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b1;2'
  878. [2025-09-03 15:42:31] VERBOSE[539259][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b1;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935731.213415,540)) complete GOSUB_RETVAL=
  879. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:1] Set("Local/340@from-queue-000087b2;2", "QAGENT=340") in new stack
  880. [2025-09-03 15:42:31] VERBOSE[538997][C-0000ed2a] app_queue.c: Called Local/340@from-queue/n
  881. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:2] Set("Local/340@from-queue-000087b2;2", "__FROMQ=true") in new stack
  882. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:3] UserEvent("Local/340@from-queue-000087b2;2", "QueueMemberCallDial,QAGENT:340,UNIQ:1756935751.213422,Queue:540,LinkedID:") in new stack
  883. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:4] Set("Local/340@from-queue-000087b2;2", "CHANNEL(hangup_handler_push)=queueMemberCall-hangup,s,1(340,1756935751.213422,540)") in new stack
  884. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:5] GotoIf("Local/340@from-queue-000087b2;2", "0?hangup") in new stack
  885. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue:6] GotoIf("Local/340@from-queue-000087b2;2", "1?540,1:hangup") in new stack
  886. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (from-queue,540,1)
  887. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [540@from-queue:1] Goto("Local/340@from-queue-000087b2;2", "from-queue-exten-internal,340,1") in new stack
  888. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (from-queue-exten-internal,340,1)
  889. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:1] GotoIf("Local/340@from-queue-000087b2;2", "0?hangup") in new stack
  890. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:2] GotoIf("Local/340@from-queue-000087b2;2", "0?from-queue-exten-only-x,340,1") in new stack
  891. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:3] Set("Local/340@from-queue-000087b2;2", "RingGroupMethod=none") in new stack
  892. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:4] Set("Local/340@from-queue-000087b2;2", "CHANNEL(language)=en") in new stack
  893. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:5] Set("Local/340@from-queue-000087b2;2", "QDOPTS=") in new stack
  894. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:6] Set("Local/340@from-queue-000087b2;2", "CALLTYPE_OVERRIDE=external") in new stack
  895. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:7] ExecIf("Local/340@from-queue-000087b2;2", "1?Set(FROMEXTEN=540)") in new stack
  896. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:8] Gosub("Local/340@from-queue-000087b2;2", "sub-record-check,s,1(exten,340,)") in new stack
  897. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/340@from-queue-000087b2;2", "3?initialized") in new stack
  898. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,10)
  899. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/340@from-queue-000087b2;2", "Recordings initialized") in new stack
  900. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/340@from-queue-000087b2;2", "1?Set(ARG3=dontcare)") in new stack
  901. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:12] Set("Local/340@from-queue-000087b2;2", "REC_POLICY_MODE_SAVE=") in new stack
  902. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(REC_STATUS=NO)") in new stack
  903. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/340@from-queue-000087b2;2", "5?checkaction") in new stack
  904. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,s,17)
  905. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/340@from-queue-000087b2;2", "1?sub-record-check,exten,1") in new stack
  906. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,1)
  907. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:1] NoOp("Local/340@from-queue-000087b2;2", "Exten Recording Check between 540 and 340") in new stack
  908. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:2] Set("Local/340@from-queue-000087b2;2", "CALLTYPE=external") in new stack
  909. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:3] ExecIf("Local/340@from-queue-000087b2;2", "8?Set(CALLTYPE=external)") in new stack
  910. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:4] Set("Local/340@from-queue-000087b2;2", "CALLEE=dontcare") in new stack
  911. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:5] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(CALLEE=dontcare)") in new stack
  912. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:6] GotoIf("Local/340@from-queue-000087b2;2", "1?callee") in new stack
  913. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,exten,11)
  914. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:11] Gosub("Local/340@from-queue-000087b2;2", "recordcheck,1(dontcare,external,340)") in new stack
  915. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/340@from-queue-000087b2;2", "Starting recording check against dontcare") in new stack
  916. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/340@from-queue-000087b2;2", "dontcare") in new stack
  917. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  918. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/340@from-queue-000087b2;2", "") in new stack
  919. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [exten@sub-record-check:12] Return("Local/340@from-queue-000087b2;2", "") in new stack
  920. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@from-queue-exten-internal:9] Gosub("Local/340@from-queue-000087b2;2", "macro-dial-one,s,1(,HhTtrU(macro-auto-blkvm),340)") in new stack
  921. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:1] Set("Local/340@from-queue-000087b2;2", "DEXTEN=340") in new stack
  922. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:2] Set("Local/340@from-queue-000087b2;2", "__CRM_SOURCE=780CALLERX") in new stack
  923. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:3] Set("Local/340@from-queue-000087b2;2", "__MCEXTTOCALL=") in new stack
  924. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:4] Set("Local/340@from-queue-000087b2;2", "__MCMULTI=5633a950a4bfbecc7eba029fcae3b10b") in new stack
  925. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:5] ExecIf("Local/340@from-queue-000087b2;2", "1?Set(__EXTTOCALL=340)") in new stack
  926. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:6] Set("Local/340@from-queue-000087b2;2", "DIALSTATUS_CW=") in new stack
  927. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:7] GosubIf("Local/340@from-queue-000087b2;2", "0?screen,1()") in new stack
  928. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:8] GosubIf("Local/340@from-queue-000087b2;2", "0?cf,1()") in new stack
  929. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:9] GotoIf("Local/340@from-queue-000087b2;2", "1?skip1") in new stack
  930. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,12)
  931. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:12] GotoIf("Local/340@from-queue-000087b2;2", "0?nodial") in new stack
  932. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/340@from-queue-000087b2;2", "0?continue") in new stack
  933. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:14] Set("Local/340@from-queue-000087b2;2", "EXTHASCW=") in new stack
  934. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:15] GotoIf("Local/340@from-queue-000087b2;2", "1?next1:cwinusebusy") in new stack
  935. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,16)
  936. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:16] GotoIf("Local/340@from-queue-000087b2;2", "0?docfu:skip3") in new stack
  937. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,20)
  938. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:20] GotoIf("Local/340@from-queue-000087b2;2", "1?next2:continue") in new stack
  939. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,21)
  940. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:21] GotoIf("Local/340@from-queue-000087b2;2", "1?continue") in new stack
  941. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,29)
  942. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:29] GotoIf("Local/340@from-queue-000087b2;2", "0?nodial") in new stack
  943. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:30] GosubIf("Local/340@from-queue-000087b2;2", "1?dstring,1():dlocal,1()") in new stack
  944. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:1] Set("Local/340@from-queue-000087b2;2", "DSTRING=") in new stack
  945. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:2] Set("Local/340@from-queue-000087b2;2", "DEVICES=340") in new stack
  946. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("Local/340@from-queue-000087b2;2", "0?Return()") in new stack
  947. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(DEVICES=40)") in new stack
  948. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:5] Set("Local/340@from-queue-000087b2;2", "LOOPCNT=1") in new stack
  949. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:6] Set("Local/340@from-queue-000087b2;2", "ITER=1") in new stack
  950. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:7] Set("Local/340@from-queue-000087b2;2", "THISDIAL=PJSIP/340") in new stack
  951. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("Local/340@from-queue-000087b2;2", "0?docheck") in new stack
  952. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("Local/340@from-queue-000087b2;2", "Debug: Found PJSIP Destination PJSIP/340") in new stack
  953. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("Local/340@from-queue-000087b2;2", "0?doset") in new stack
  954. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("Local/340@from-queue-000087b2;2", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
  955. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:12] Set("Local/340@from-queue-000087b2;2", "THISDIAL=PJSIP/340/sip:[email protected]:5060") in new stack
  956. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
  957. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("Local/340@from-queue-000087b2;2", "0?skipset") in new stack
  958. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:15] Set("Local/340@from-queue-000087b2;2", "DSTRING=PJSIP/340/sip:[email protected]:5060&") in new stack
  959. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:16] Set("Local/340@from-queue-000087b2;2", "ITER=2") in new stack
  960. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("Local/340@from-queue-000087b2;2", "0?begin") in new stack
  961. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("Local/340@from-queue-000087b2;2", "0?Return()") in new stack
  962. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:19] Set("Local/340@from-queue-000087b2;2", "DSTRING=PJSIP/340/sip:[email protected]:5060") in new stack
  963. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [dstring@macro-dial-one:20] Return("Local/340@from-queue-000087b2;2", "") in new stack
  964. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:31] GotoIf("Local/340@from-queue-000087b2;2", "0?nodial") in new stack
  965. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:32] GotoIf("Local/340@from-queue-000087b2;2", "0?skiptrace") in new stack
  966. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:33] GosubIf("Local/340@from-queue-000087b2;2", "1?ctset,1():ctclear,1()") in new stack
  967. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:1] Set("Local/340@from-queue-000087b2;2", "DB(CALLTRACE/340)=780CALLERX") in new stack
  968. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [ctset@macro-dial-one:2] Return("Local/340@from-queue-000087b2;2", "") in new stack
  969. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:34] Set("Local/340@from-queue-000087b2;2", "D_OPTIONS=HhTtrU(macro-auto-blkvm)") in new stack
  970. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:35] GosubIf("Local/340@from-queue-000087b2;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  971. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:36] NoOp("Local/340@from-queue-000087b2;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  972. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:37] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(ALERT_INFO=)") in new stack
  973. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:38] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(ALERT_INFO=)") in new stack
  974. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:39] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(ALERT_INFO=)") in new stack
  975. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:40] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  976. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:41] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  977. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:42] GosubIf("Local/340@from-queue-000087b2;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  978. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:43] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(CHANNEL(musicclass)=)") in new stack
  979. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:44] GosubIf("Local/340@from-queue-000087b2;2", "0?qwait,1()") in new stack
  980. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:45] Set("Local/340@from-queue-000087b2;2", "__CWIGNORE=TRUE") in new stack
  981. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:46] Set("Local/340@from-queue-000087b2;2", "__KEEPCID=TRUE") in new stack
  982. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:47] GotoIf("Local/340@from-queue-000087b2;2", "0?usegoto,1") in new stack
  983. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:48] GotoIf("Local/340@from-queue-000087b2;2", "1?godial") in new stack
  984. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-dial-one,s,53)
  985. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:53] Gosub("Local/340@from-queue-000087b2;2", "macro-dialout-one-predial-hook,s,1()") in new stack
  986. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] Return("Local/340@from-queue-000087b2;2", "") in new stack
  987. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:54] ExecIf("Local/340@from-queue-000087b2;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  988. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:55] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
  989. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:56] NoOp("Local/340@from-queue-000087b2;2", "") in new stack
  990. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:57] ExecIf("Local/340@from-queue-000087b2;2", "1?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)I)") in new stack
  991. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:58] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(D_OPTIONS=HhtrU(macro-auto-blkvm)Ig)") in new stack
  992. [2025-09-03 15:42:31] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-dial-one:59] Gosub("Local/340@from-queue-000087b2;2", "dialOne-with-exten,340,1()") in new stack
  993. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:1] Set("Local/340@from-queue-000087b2;2", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,,1") in new stack
  994. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@dialOne-with-exten:2] Dial("Local/340@from-queue-000087b2;2", "PJSIP/340/sip:[email protected]:5060,,HhtrU(macro-auto-blkvm)Ib(func-apply-sipheaders^s^1)") in new stack
  995. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(func-apply-sipheaders,s,1) start
  996. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/340-00021395", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  997. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/340-00021395", "Applying SIP Headers to channel PJSIP/340-00021395") in new stack
  998. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/340-00021395", "localchan=340-00021395") in new stack
  999. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/340-00021395", "DialMCEXT=340") in new stack
  1000. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:5] Set("PJSIP/340-00021395", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,340,1") in new stack
  1001. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:6] Set("PJSIP/340-00021395", "Dchan=340-00021395") in new stack
  1002. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:7] Set("PJSIP/340-00021395", "TECH=PJSIP") in new stack
  1003. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:8] Set("PJSIP/340-00021395", "SIPHEADERKEYS=") in new stack
  1004. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:9] While("PJSIP/340-00021395", "0") in new stack
  1005. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_while.c: Jumping to priority 15
  1006. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@func-apply-sipheaders:16] Return("PJSIP/340-00021395", "") in new stack
  1007. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021395'
  1008. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  1009. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_dial.c: Called PJSIP/340/sip:[email protected]:5060
  1010. [2025-09-03 15:42:32] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087b2;1 is ringing
  1011. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_dial.c: Connected line update to Local/340@from-queue-000087b2;2 prevented.
  1012. [2025-09-03 15:42:32] VERBOSE[539347][C-0000ed2a] app_dial.c: PJSIP/340-00021395 is ringing
  1013. [2025-09-03 15:42:32] VERBOSE[538997][C-0000ed2a] app_queue.c: Local/340@from-queue-000087b2;1 is ringing
  1014. [2025-09-03 15:42:50] VERBOSE[538997][C-0000ed2a] app_queue.c: Nobody picked up in 19000 ms
  1015. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(app-missedcall-hangup,340,1) start
  1016. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("PJSIP/340-00021395", "Dialed: 340") in new stack
  1017. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("PJSIP/340-00021395", "Caller: ") in new stack
  1018. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("PJSIP/340-00021395", "0?exit") in new stack
  1019. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("PJSIP/340-00021395", "EXTENNUM=340") in new stack
  1020. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("PJSIP/340-00021395", "FEXTENNUM=340") in new stack
  1021. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("PJSIP/340-00021395", "0?exit") in new stack
  1022. [2025-09-03 15:42:50] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("PJSIP/340-00021395", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,PJSIP/340-00021395,,540,,") in new stack
  1023. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] res_agi.c: <PJSIP/340-00021395>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  1024. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("PJSIP/340-00021395", "") in new stack
  1025. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021395'
  1026. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  1027. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(crm-hangup,s,1) start
  1028. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/340-00021395", "Sending Hangup to CRM") in new stack
  1029. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/340-00021395", "HANGUP CAUSE: 26") in new stack
  1030. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/340-00021395", "0?Set(__CRM_VOICEMAIL=)") in new stack
  1031. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/340-00021395", "MASTER CHANNEL: 1756935752.213423 = 1756935698.213397") in new stack
  1032. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/340-00021395", "1?return") in new stack
  1033. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (crm-hangup,s,8)
  1034. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/340-00021395", "") in new stack
  1035. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Spawn extension (from-ds-phone, 340, 1) exited non-zero on 'PJSIP/340-00021395'
  1036. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: PJSIP/340-00021395 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  1037. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Spawn extension (dialOne-with-exten, 340, 2) exited non-zero on 'Local/340@from-queue-000087b2;2'
  1038. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [h@dialOne-with-exten:1] Gosub("Local/340@from-queue-000087b2;2", "macro-hangupcall,s,1()") in new stack
  1039. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:1] Set("Local/340@from-queue-000087b2;2", "__MCVMSTATUS=") in new stack
  1040. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:2] Gosub("Local/340@from-queue-000087b2;2", "app-missedcall-hangup,s,1()") in new stack
  1041. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087b2;2", "Dialed: s") in new stack
  1042. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087b2;2", "Caller: ") in new stack
  1043. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087b2;2", "1?exit") in new stack
  1044. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (app-missedcall-hangup,s,8)
  1045. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@app-missedcall-hangup:8] Return("Local/340@from-queue-000087b2;2", "") in new stack
  1046. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:3] UserEvent("Local/340@from-queue-000087b2;2", "MES,RTPAUDIOQOSMESBRIDGED:,RTPAUDIOQOSMES:") in new stack
  1047. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:4] GotoIf("Local/340@from-queue-000087b2;2", "1?theend") in new stack
  1048. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx_builtins.c: Goto (macro-hangupcall,s,6)
  1049. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:6] ExecIf("Local/340@from-queue-000087b2;2", "0?Set(CDR(recordingfile)=)") in new stack
  1050. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@macro-hangupcall:7] Hangup("Local/340@from-queue-000087b2;2", "") in new stack
  1051. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b2;2'
  1052. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b2;2 Internal Gosub(app-missedcall-hangup,340,1) start
  1053. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:1] NoOp("Local/340@from-queue-000087b2;2", "Dialed: 340") in new stack
  1054. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:2] NoOp("Local/340@from-queue-000087b2;2", "Caller: ") in new stack
  1055. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:3] GotoIf("Local/340@from-queue-000087b2;2", "0?exit") in new stack
  1056. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:4] Set("Local/340@from-queue-000087b2;2", "EXTENNUM=340") in new stack
  1057. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:5] Set("Local/340@from-queue-000087b2;2", "FEXTENNUM=340") in new stack
  1058. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:6] GotoIf("Local/340@from-queue-000087b2;2", "0?exit") in new stack
  1059. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:7] AGI("Local/340@from-queue-000087b2;2", "agi://127.0.0.1/missedcallnotify.php,340,,340,0,,Local/340@from-queue-000087b2;2,CANCEL,540,,") in new stack
  1060. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] res_agi.c: <Local/340@from-queue-000087b2;2>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0
  1061. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [340@app-missedcall-hangup:8] Return("Local/340@from-queue-000087b2;2", "") in new stack
  1062. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b2;2'
  1063. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b2;2 Internal Gosub(app-missedcall-hangup,340,1) complete GOSUB_RETVAL=
  1064. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b2;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935751.213422,540)) start
  1065. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:1] NoOp("Local/340@from-queue-000087b2;2", "340") in new stack
  1066. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:2] UserEvent("Local/340@from-queue-000087b2;2", "QueueMemberCallHangup,QAGENT:340,UNIQ:1756935751.213422,Queue:540,DIALSTATUS:CANCEL") in new stack
  1067. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] pbx.c: Executing [s@queueMemberCall-hangup:3] Return("Local/340@from-queue-000087b2;2", "") in new stack
  1068. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/340@from-queue-000087b2;2'
  1069. [2025-09-03 15:42:51] VERBOSE[539347][C-0000ed2a] app_stack.c: Local/340@from-queue-000087b2;2 Internal Gosub(queueMemberCall-hangup,s,1(340,1756935751.213422,540)) complete GOSUB_RETVAL=
  1070. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:72] Gosub("PJSIP/thinktel-edm-0002138b", "macro-blkvm-clr,s,1()") in new stack
  1071. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-clr:1] Set("PJSIP/thinktel-edm-0002138b", "SHARED(BLKVM,PJSIP/thinktel-edm-0002138b)=") in new stack
  1072. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-clr:2] Set("PJSIP/thinktel-edm-0002138b", "GOSUB_RETVAL=") in new stack
  1073. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-clr:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1074. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:73] Gosub("PJSIP/thinktel-edm-0002138b", "sub-record-cancel,s,1()") in new stack
  1075. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@sub-record-cancel:1] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1076. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:74] Set("PJSIP/thinktel-edm-0002138b", "__NODEST=") in new stack
  1077. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:75] Set("PJSIP/thinktel-edm-0002138b", "_QUEUE_PRIO=0") in new stack
  1078. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:76] Set("PJSIP/thinktel-edm-0002138b", "__CWIGNORE=") in new stack
  1079. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:77] Set("PJSIP/thinktel-edm-0002138b", "__CFIGNORE=") in new stack
  1080. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:78] Set("PJSIP/thinktel-edm-0002138b", "__FORWARD_CONTEXT=from-internal") in new stack
  1081. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:79] Set("PJSIP/thinktel-edm-0002138b", "QRINGOPTS=") in new stack
  1082. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:80] Set("PJSIP/thinktel-edm-0002138b", "QDEST=") in new stack
  1083. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:81] Set("PJSIP/thinktel-edm-0002138b", "VQ_DEST=") in new stack
  1084. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:82] Set("PJSIP/thinktel-edm-0002138b", "_CALLER_DEST=") in new stack
  1085. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:83] Set("PJSIP/thinktel-edm-0002138b", "_AGENT_DEST=") in new stack
  1086. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:84] Set("PJSIP/thinktel-edm-0002138b", "QFULL_DEST=") in new stack
  1087. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:85] Set("PJSIP/thinktel-edm-0002138b", "VQ_FULL_DEST=") in new stack
  1088. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:86] GotoIf("PJSIP/thinktel-edm-0002138b", "0?,,") in new stack
  1089. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:87] Set("PJSIP/thinktel-edm-0002138b", "QJOINEMPTY_DEST=") in new stack
  1090. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:88] Set("PJSIP/thinktel-edm-0002138b", "VQ_JOINEMPTY_DEST=") in new stack
  1091. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:89] GotoIf("PJSIP/thinktel-edm-0002138b", "0?,,") in new stack
  1092. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:90] Set("PJSIP/thinktel-edm-0002138b", "QLEAVEEMPTY_DEST=") in new stack
  1093. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:91] Set("PJSIP/thinktel-edm-0002138b", "VQ_LEAVEEMPTY_DEST=") in new stack
  1094. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:92] GotoIf("PJSIP/thinktel-edm-0002138b", "0?,,") in new stack
  1095. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:93] Set("PJSIP/thinktel-edm-0002138b", "QJOINUNAVAIL_DEST=") in new stack
  1096. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:94] Set("PJSIP/thinktel-edm-0002138b", "VQ_JOINUNAVAIL_DEST=") in new stack
  1097. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:95] GotoIf("PJSIP/thinktel-edm-0002138b", "0?,,") in new stack
  1098. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:96] Set("PJSIP/thinktel-edm-0002138b", "QLEAVEUNAVAIL_DEST=") in new stack
  1099. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:97] Set("PJSIP/thinktel-edm-0002138b", "VQ_LEAVEUNAVAIL_DEST=") in new stack
  1100. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:98] GotoIf("PJSIP/thinktel-edm-0002138b", "0?,,") in new stack
  1101. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [540@ext-queues:99] GotoIf("PJSIP/thinktel-edm-0002138b", "1?ext-local,vmu640,1:,,") in new stack
  1102. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (ext-local,vmu640,1)
  1103. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmu640@ext-local:1] Gosub("PJSIP/thinktel-edm-0002138b", "macro-vm,s,1(640,NOANSWER,)") in new stack
  1104. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-vm:1] Gosub("PJSIP/thinktel-edm-0002138b", "macro-user-callerid,s,1(SKIPTTL)") in new stack
  1105. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/thinktel-edm-0002138b", "TOUCH_MONITOR=1756935698.213397") in new stack
  1106. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/thinktel-edm-0002138b", "CHANCONTEXT=") in new stack
  1107. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/thinktel-edm-0002138b", "CHANCONTEXT=") in new stack
  1108. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/thinktel-edm-0002138b", "CHANEXTENCONTEXT=thinktel-edm-0002138b") in new stack
  1109. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/thinktel-edm-0002138b", "CHANEXTEN=thinktel-edm-0002138b") in new stack
  1110. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(number)=780CALLERX") in new stack
  1111. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/thinktel-edm-0002138b", "AMPUSER=780CALLERX") in new stack
  1112. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/thinktel-edm-0002138b", "HOTDESCKCHAN=thinktel-edm-0002138b") in new stack
  1113. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/thinktel-edm-0002138b", "HOTDESKEXTEN=thinktel") in new stack
  1114. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/thinktel-edm-0002138b", "HOTDESKCALL=0") in new stack
  1115. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(HOTDESKCALL=1)") in new stack
  1116. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(CALLERID(name)=)") in new stack
  1117. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/thinktel-edm-0002138b", "0?report") in new stack
  1118. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(REALCALLERIDNUM=780CALLERX)") in new stack
  1119. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/thinktel-edm-0002138b", "AMPUSER=") in new stack
  1120. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/thinktel-edm-0002138b", "0?limit") in new stack
  1121. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/thinktel-edm-0002138b", "AMPUSERCIDNAME=") in new stack
  1122. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  1123. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/thinktel-edm-0002138b", "1?report") in new stack
  1124. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-user-callerid,s,28)
  1125. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/thinktel-edm-0002138b", "Macro depricated!! To keep the same line numbers") in new stack
  1126. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/thinktel-edm-0002138b", "Macro depricated !!  To keep the same line numbers") in new stack
  1127. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/thinktel-edm-0002138b", "1?continue") in new stack
  1128. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-user-callerid,s,49)
  1129. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(number)=780CALLERX") in new stack
  1130. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/thinktel-edm-0002138b", "CALLERID(name)=Transp:780CALLERX") in new stack
  1131. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("PJSIP/thinktel-edm-0002138b", "0?cnum") in new stack
  1132. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/thinktel-edm-0002138b", "__MCNUM=780CALLERX") in new stack
  1133. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/thinktel-edm-0002138b", "__MCNAME=Transp:780CALLERX") in new stack
  1134. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/thinktel-edm-0002138b", "__MCEXTEN=") in new stack
  1135. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/thinktel-edm-0002138b", "__MCORGCHAN=PJSIP/thinktel-edm-0002138b") in new stack
  1136. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:56] Set("PJSIP/thinktel-edm-0002138b", "CDR(cnam)=Transp:780CALLERX") in new stack
  1137. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:57] Set("PJSIP/thinktel-edm-0002138b", "CDR(cnum)=780CALLERX") in new stack
  1138. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:58] GosubIf("PJSIP/thinktel-edm-0002138b", "0?app-check-classofservce,s,1()") in new stack
  1139. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-user-callerid:59] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1140. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-vm:2] Set("PJSIP/thinktel-edm-0002138b", "VMGAIN=") in new stack
  1141. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-vm:3] Gosub("PJSIP/thinktel-edm-0002138b", "macro-blkvm-check,s,1()") in new stack
  1142. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-check:1] Set("PJSIP/thinktel-edm-0002138b", "GOSUB_RETVAL=") in new stack
  1143. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf("PJSIP/thinktel-edm-0002138b", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
  1144. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-blkvm-check:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1145. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-vm:4] GotoIf("PJSIP/thinktel-edm-0002138b", "1?vmx,1") in new stack
  1146. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-vm,vmx,1)
  1147. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:1] Set("PJSIP/thinktel-edm-0002138b", "__EXTTOCALL=640") in new stack
  1148. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:2] Set("PJSIP/thinktel-edm-0002138b", "__CRM_VOICEMAIL=640") in new stack
  1149. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:3] Set("PJSIP/thinktel-edm-0002138b", "MEXTEN=640") in new stack
  1150. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:4] Set("PJSIP/thinktel-edm-0002138b", "MMODE=NOANSWER") in new stack
  1151. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:5] Set("PJSIP/thinktel-edm-0002138b", "RETVM=") in new stack
  1152. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:6] Set("PJSIP/thinktel-edm-0002138b", "MODE=unavail") in new stack
  1153. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:7] Gosub("PJSIP/thinktel-edm-0002138b", "macro-get-vmcontext,s,1(640)") in new stack
  1154. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/thinktel-edm-0002138b", "VMCONTEXT=default") in new stack
  1155. [2025-09-03 15:42:51] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/thinktel-edm-0002138b", "0?200:300") in new stack
  1156. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
  1157. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/thinktel-edm-0002138b", "") in new stack
  1158. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:301] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1159. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:8] Set("PJSIP/thinktel-edm-0002138b", "MODE=unavail") in new stack
  1160. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:9] NoOp("PJSIP/thinktel-edm-0002138b", "MODE IS: unavail") in new stack
  1161. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:10] GotoIf("PJSIP/thinktel-edm-0002138b", "1?chknomsg") in new stack
  1162. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-vm,vmx,12)
  1163. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:12] GotoIf("PJSIP/thinktel-edm-0002138b", "0?s-NOANSWER,1") in new stack
  1164. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:13] GotoIf("PJSIP/thinktel-edm-0002138b", "1?notdirect") in new stack
  1165. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-vm,vmx,15)
  1166. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:15] NoOp("PJSIP/thinktel-edm-0002138b", "Checking if ext 640 is enabled: blocked") in new stack
  1167. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [vmx@macro-vm:16] GotoIf("PJSIP/thinktel-edm-0002138b", "1?s-NOANSWER,1") in new stack
  1168. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-vm,s-NOANSWER,1)
  1169. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s-NOANSWER@macro-vm:1] Gosub("PJSIP/thinktel-edm-0002138b", "macro-get-vmcontext,s,1(640)") in new stack
  1170. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/thinktel-edm-0002138b", "VMCONTEXT=default") in new stack
  1171. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/thinktel-edm-0002138b", "0?200:300") in new stack
  1172. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
  1173. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/thinktel-edm-0002138b", "") in new stack
  1174. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@macro-get-vmcontext:301] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1175. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s-NOANSWER@macro-vm:2] VoiceMail("PJSIP/thinktel-edm-0002138b", "640@default,u") in new stack
  1176. [2025-09-03 15:42:52] VERBOSE[538997][C-0000ed2a] file.c: <PJSIP/thinktel-edm-0002138b> Playing '/var/spool/asterisk/voicemail/default/640/unavail.slin' (language 'en')
  1177. [2025-09-03 15:43:03] VERBOSE[538997][C-0000ed2a] file.c: <PJSIP/thinktel-edm-0002138b> Playing 'vm-intro.ulaw' (language 'en')
  1178. [2025-09-03 15:43:09] VERBOSE[538997][C-0000ed2a] file.c: <PJSIP/thinktel-edm-0002138b> Playing 'beep.ulaw' (language 'en')
  1179. [2025-09-03 15:43:09] VERBOSE[538997][C-0000ed2a] app_voicemail.c: Recording the message
  1180. [2025-09-03 15:43:59] VERBOSE[538997][C-0000ed2a] app.c: User hung up
  1181. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'PJSIP/thinktel-edm-0002138b'
  1182. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: PJSIP/thinktel-edm-0002138b Internal Gosub(queueCall-hangup,s,1(540,1756935698.213397,PJSIP/thinktel-edm-0002138b)) start
  1183. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@queueCall-hangup:1] NoOp("PJSIP/thinktel-edm-0002138b", "540") in new stack
  1184. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@queueCall-hangup:2] UserEvent("PJSIP/thinktel-edm-0002138b", "QueueCallHangup,Q:540,UNIQ:1756935698.213397,CHAN:PJSIP/thinktel-edm-0002138b,SCD_CONNECT_AGENT:") in new stack
  1185. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@queueCall-hangup:3] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1186. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'PJSIP/thinktel-edm-0002138b'
  1187. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: PJSIP/thinktel-edm-0002138b Internal Gosub(queueCall-hangup,s,1(540,1756935698.213397,PJSIP/thinktel-edm-0002138b)) complete GOSUB_RETVAL=
  1188. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: PJSIP/thinktel-edm-0002138b Internal Gosub(crm-hangup,s,1) start
  1189. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/thinktel-edm-0002138b", "Sending Hangup to CRM") in new stack
  1190. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/thinktel-edm-0002138b", "HANGUP CAUSE: 16") in new stack
  1191. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/thinktel-edm-0002138b", "1?Set(__CRM_VOICEMAIL=SUCCESS)") in new stack
  1192. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/thinktel-edm-0002138b", "MASTER CHANNEL: 1756935698.213397 = 1756935698.213397") in new stack
  1193. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/thinktel-edm-0002138b", "0?return") in new stack
  1194. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/thinktel-edm-0002138b", "__CRM_HANGUP=1") in new stack
  1195. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/thinktel-edm-0002138b", "agi://127.0.0.1/sangomacrm.agi") in new stack
  1196. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: LINKEDID: 1756935698.213397
  1197. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: SOURCE: 780CALLERX
  1198. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: DESTINATION:
  1199. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: DIRECTION: INBOUND
  1200. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: EXTTOCALL: 640
  1201. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: START
  1202. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: agi://127.0.0.1/sangomacrm.agi: SCRIPT: php /var/www/html/admin/modules/sangomacrm/importOne.php 'eyJ1dWlkIjoiMTc1NjkzNTY5OC4yMTMzOTciLCJzb3VyY2UiOiI3ODAyODkwMDY0IiwiZGVzdGluYXRpb24iOiIiLCJkaXJlY3Rpb24iOiJJTkJPVU5EIiwidHlwZSI6IkVORCIsInp1bHVfcmF3X3R5cGUiOiIiLCJ6dWx1X3R5cGUiOiIiLCJ6dWx1X3VybCI6IiIsImV4dHRvY2FsbCI6IjY0MCIsImNudW0iOiI3ODAyODkwMDY0IiwiY25hbSI6IlRyYW5zcDo3ODAyODkwMDY0IiwiY2FsbHBvcCI6ZmFsc2UsInZvaWNlbWFpbCI6IlNVQ0NFU1MiLCJmcm9tX2RpZCI6Ijc4MDQxOTY1NDAifQ==' > /dev/null 2>&1 &
  1203. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] res_agi.c: <PJSIP/thinktel-edm-0002138b>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  1204. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/thinktel-edm-0002138b", "") in new stack
  1205. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'PJSIP/thinktel-edm-0002138b'
  1206. [2025-09-03 15:44:00] VERBOSE[538997][C-0000ed2a] app_stack.c: PJSIP/thinktel-edm-0002138b Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  1207.  

Reply to "queue trace"

Here you can reply to the paste above

Sangoma Terms of Use & Policies

Powered by Stikked