Automatic Pastebin from FreePBX Distro 6

From root@vps1540489409.freepbxhostin, 1 Month ago, written in Plain Text, viewed 3 times.
URL https://pastebin.freepbx.org/view/85db2b95 Embed
Download Paste or View Raw
  1. [2019-10-25 08:46:29] VERBOSE[21026][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  2. [2019-10-25 08:46:29] VERBOSE[21026][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  3. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [2393343131@from-trunk:1] NoOp("SIP/vitel-inbound-000dd0cb", "Catch-All DID Match - Found 2393343131 - You probably want a DID for this.") in new stack
  4. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [2393343131@from-trunk:2] Set("SIP/vitel-inbound-000dd0cb", "__FROM_DID=2393343131") in new stack
  5. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [2393343131@from-trunk:3] Goto("SIP/vitel-inbound-000dd0cb", "ext-did,s,1") in new stack
  6. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (ext-did,s,1)
  7. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:1] Set("SIP/vitel-inbound-000dd0cb", "__DIRECTION=INBOUND") in new stack
  8. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:2] Gosub("SIP/vitel-inbound-000dd0cb", "sub-record-check,s,1(in,s,dontcare)") in new stack
  9. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:1] GotoIf("SIP/vitel-inbound-000dd0cb", "0?initialized") in new stack
  10. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:2] Set("SIP/vitel-inbound-000dd0cb", "__REC_STATUS=INITIALIZED") in new stack
  11. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:3] Set("SIP/vitel-inbound-000dd0cb", "NOW=1572007589") in new stack
  12. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:4] Set("SIP/vitel-inbound-000dd0cb", "__DAY=25") in new stack
  13. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:5] Set("SIP/vitel-inbound-000dd0cb", "__MONTH=10") in new stack
  14. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:6] Set("SIP/vitel-inbound-000dd0cb", "__YEAR=2019") in new stack
  15. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:7] Set("SIP/vitel-inbound-000dd0cb", "__TIMESTR=20191025-084629") in new stack
  16. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:8] Set("SIP/vitel-inbound-000dd0cb", "__FROMEXTEN=unknown") in new stack
  17. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:9] Set("SIP/vitel-inbound-000dd0cb", "__MON_FMT=wav") in new stack
  18. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:10] NoOp("SIP/vitel-inbound-000dd0cb", "Recordings initialized") in new stack
  19. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:11] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ARG3=dontcare)") in new stack
  20. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:12] Set("SIP/vitel-inbound-000dd0cb", "REC_POLICY_MODE_SAVE=") in new stack
  21. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:13] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(REC_STATUS=NO)") in new stack
  22. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:14] GotoIf("SIP/vitel-inbound-000dd0cb", "2?checkaction") in new stack
  23. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,s,17)
  24. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:17] GotoIf("SIP/vitel-inbound-000dd0cb", "1?sub-record-check,in,1") in new stack
  25. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,in,1)
  26. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [in@sub-record-check:1] NoOp("SIP/vitel-inbound-000dd0cb", "Inbound Recording Check to s") in new stack
  27. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [in@sub-record-check:2] Set("SIP/vitel-inbound-000dd0cb", "FROMEXTEN=unknown") in new stack
  28. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [in@sub-record-check:3] ExecIf("SIP/vitel-inbound-000dd0cb", "10?Set(FROMEXTEN=2399615003)") in new stack
  29. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [in@sub-record-check:4] Gosub("SIP/vitel-inbound-000dd0cb", "recordcheck,1(dontcare,in,s)") in new stack
  30. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/vitel-inbound-000dd0cb", "Starting recording check against dontcare") in new stack
  31. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:2] Goto("SIP/vitel-inbound-000dd0cb", "dontcare") in new stack
  32. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,recordcheck,3)
  33. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:3] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  34. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [in@sub-record-check:5] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  35. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:3] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(__FROM_DID=s)") in new stack
  36. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:4] Set("SIP/vitel-inbound-000dd0cb", "returnhere=1") in new stack
  37. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:5] Gosub("SIP/vitel-inbound-000dd0cb", "app-blacklist-check,s,1()") in new stack
  38. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@app-blacklist-check:1] GotoIf("SIP/vitel-inbound-000dd0cb", "0?blacklisted") in new stack
  39. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@app-blacklist-check:2] Set("SIP/vitel-inbound-000dd0cb", "CALLED_BLACKLIST=1") in new stack
  40. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@app-blacklist-check:3] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  41. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:6] Set("SIP/vitel-inbound-000dd0cb", "CDR(did)=2393343131") in new stack
  42. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:7] GotoIf("SIP/vitel-inbound-000dd0cb", "0?") in new stack
  43. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:8] ExecIf("SIP/vitel-inbound-000dd0cb", "0 ?Set(CALLERID(name)=2399615003)") in new stack
  44. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:9] Set("SIP/vitel-inbound-000dd0cb", "CHANNEL(musicclass)=ClassicRockStream") in new stack
  45. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:10] Set("SIP/vitel-inbound-000dd0cb", "__MOHCLASS=ClassicRockStream") in new stack
  46. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:11] Set("SIP/vitel-inbound-000dd0cb", "__REVERSAL_REJECT=FALSE") in new stack
  47. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:12] GotoIf("SIP/vitel-inbound-000dd0cb", "1?post-reverse-charge") in new stack
  48. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (ext-did,s,14)
  49. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:14] NoOp("SIP/vitel-inbound-000dd0cb", "") in new stack
  50. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:15] Set("SIP/vitel-inbound-000dd0cb", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  51. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:16] Set("SIP/vitel-inbound-000dd0cb", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  52. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:17] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(name-pres)=allowed_not_screened") in new stack
  53. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:18] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(num-pres)=allowed_not_screened") in new stack
  54. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:19] Set("SIP/vitel-inbound-000dd0cb", "__ALERT_INFO=external1") in new stack
  55. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:20] NoOp("SIP/vitel-inbound-000dd0cb", "CallerID Entry Point") in new stack
  56. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:21] Set("SIP/vitel-inbound-000dd0cb", "__CRM_DIRECTION=INBOUND") in new stack
  57. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:22] Set("SIP/vitel-inbound-000dd0cb", "__CRM_SOURCE=2399615003") in new stack
  58. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:23] Set("SIP/vitel-inbound-000dd0cb", "__CRM_LINKEDID=1572007589.911605") in new stack
  59. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:24] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  60. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@ext-did:25] Goto("SIP/vitel-inbound-000dd0cb", "timeconditions,1,1") in new stack
  61. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (timeconditions,1,1)
  62. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:1] Set("SIP/vitel-inbound-000dd0cb", "DB(TC/1/INUSESTATE)=INUSE") in new stack
  63. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:2] Set("SIP/vitel-inbound-000dd0cb", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
  64. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:3] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  65. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:4] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  66. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:5] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,thu,22-28,nov?truestate") in new stack
  67. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:6] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  68. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:7] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  69. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:8] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,mon,1-7,sep?truestate") in new stack
  70. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:9] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  71. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:10] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  72. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:11] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,*,4,jul?truestate") in new stack
  73. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:12] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  74. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:13] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  75. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:14] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,mon,25-31,may?truestate") in new stack
  76. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:15] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  77. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:16] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  78. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:17] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,*,1,jan?truestate") in new stack
  79. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:18] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  80. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:19] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  81. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:20] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,sat-sun,*,*?truestate") in new stack
  82. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:21] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  83. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:22] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  84. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:23] GotoIfTime("SIP/vitel-inbound-000dd0cb", "17:00-08:00,mon-fri,*,*?truestate") in new stack
  85. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:24] NoOp("SIP/vitel-inbound-000dd0cb", "TIMENOW: 08:46,Fri,25,Oct") in new stack
  86. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:25] NoOp("SIP/vitel-inbound-000dd0cb", "TIMEMATCHED: FALSE") in new stack
  87. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:26] GotoIfTime("SIP/vitel-inbound-000dd0cb", "*,*,25,dec?truestate") in new stack
  88. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:27] GotoIf("SIP/vitel-inbound-000dd0cb", "0?truegoto") in new stack
  89. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:28] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(DB(TC/1)=)") in new stack
  90. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:29] Set("SIP/vitel-inbound-000dd0cb", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
  91. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:30] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
  92. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [1@timeconditions:31] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ext-group,600,1") in new stack
  93. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (ext-group,600,1)
  94. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:1] GotoIf("SIP/vitel-inbound-000dd0cb", "0?cid") in new stack
  95. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:2] PlayTones("SIP/vitel-inbound-000dd0cb", "ring") in new stack
  96. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:3] Progress("SIP/vitel-inbound-000dd0cb", "") in new stack
  97. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:4] Macro("SIP/vitel-inbound-000dd0cb", "user-callerid,") in new stack
  98. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:1] Set("SIP/vitel-inbound-000dd0cb", "TOUCH_MONITOR=1572007589.911605") in new stack
  99. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:2] Set("SIP/vitel-inbound-000dd0cb", "AMPUSER=2399615003") in new stack
  100. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:3] GotoIf("SIP/vitel-inbound-000dd0cb", "0?report") in new stack
  101. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:4] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(REALCALLERIDNUM=2399615003)") in new stack
  102. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:5] Set("SIP/vitel-inbound-000dd0cb", "AMPUSER=") in new stack
  103. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:6] GotoIf("SIP/vitel-inbound-000dd0cb", "0?limit") in new stack
  104. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:7] Set("SIP/vitel-inbound-000dd0cb", "AMPUSERCIDNAME=") in new stack
  105. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:8] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  106. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:9] GotoIf("SIP/vitel-inbound-000dd0cb", "1?report") in new stack
  107. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,16)
  108. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:16] NoOp("SIP/vitel-inbound-000dd0cb", "Macro Depth is 1") in new stack
  109. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:17] GotoIf("SIP/vitel-inbound-000dd0cb", "1?report2:macroerror") in new stack
  110. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,18)
  111. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:18] GotoIf("SIP/vitel-inbound-000dd0cb", "0?continue") in new stack
  112. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:19] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  113. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:20] Set("SIP/vitel-inbound-000dd0cb", "__TTL=64") in new stack
  114. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:21] GotoIf("SIP/vitel-inbound-000dd0cb", "1?continue") in new stack
  115. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,37)
  116. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:37] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(number)=2399615003") in new stack
  117. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:38] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(name)=2399615003") in new stack
  118. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:39] GotoIf("SIP/vitel-inbound-000dd0cb", "0?cnum") in new stack
  119. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:40] Set("SIP/vitel-inbound-000dd0cb", "CDR(cnam)=2399615003") in new stack
  120. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:41] Set("SIP/vitel-inbound-000dd0cb", "CDR(cnum)=2399615003") in new stack
  121. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:42] Set("SIP/vitel-inbound-000dd0cb", "CHANNEL(language)=en") in new stack
  122. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:5] Macro("SIP/vitel-inbound-000dd0cb", "blkvm-setifempty,") in new stack
  123. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/vitel-inbound-000dd0cb", "1?init") in new stack
  124. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-blkvm-setifempty,s,4)
  125. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-setifempty:4] Set("SIP/vitel-inbound-000dd0cb", "__BLKVM_CHANNEL=SIP/vitel-inbound-000dd0cb") in new stack
  126. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-setifempty:5] Set("SIP/vitel-inbound-000dd0cb", "SHARED(BLKVM,SIP/vitel-inbound-000dd0cb)=TRUE") in new stack
  127. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-setifempty:6] Set("SIP/vitel-inbound-000dd0cb", "GOSUB_RETVAL=TRUE") in new stack
  128. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/vitel-inbound-000dd0cb", "") in new stack
  129. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:6] GotoIf("SIP/vitel-inbound-000dd0cb", "1?skipov") in new stack
  130. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (ext-group,600,9)
  131. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:9] Set("SIP/vitel-inbound-000dd0cb", "RRNODEST=") in new stack
  132. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:10] Set("SIP/vitel-inbound-000dd0cb", "__NODEST=600") in new stack
  133. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:11] GosubIf("SIP/vitel-inbound-000dd0cb", "0?sub-rgsetcid,s,1()") in new stack
  134. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:12] Gosub("SIP/vitel-inbound-000dd0cb", "sub-record-check,s,1(rg,600,dontcare)") in new stack
  135. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:1] GotoIf("SIP/vitel-inbound-000dd0cb", "10?initialized") in new stack
  136. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,s,10)
  137. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:10] NoOp("SIP/vitel-inbound-000dd0cb", "Recordings initialized") in new stack
  138. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:11] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ARG3=dontcare)") in new stack
  139. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:12] Set("SIP/vitel-inbound-000dd0cb", "REC_POLICY_MODE_SAVE=") in new stack
  140. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:13] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(REC_STATUS=NO)") in new stack
  141. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:14] GotoIf("SIP/vitel-inbound-000dd0cb", "2?checkaction") in new stack
  142. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,s,17)
  143. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:17] GotoIf("SIP/vitel-inbound-000dd0cb", "0?sub-record-check,rg,1") in new stack
  144. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:18] NoOp("SIP/vitel-inbound-000dd0cb", "Generic rg Recording Check - 2399615003 600") in new stack
  145. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:19] Gosub("SIP/vitel-inbound-000dd0cb", "recordcheck,1(dontcare,rg,600)") in new stack
  146. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/vitel-inbound-000dd0cb", "Starting recording check against dontcare") in new stack
  147. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:2] Goto("SIP/vitel-inbound-000dd0cb", "dontcare") in new stack
  148. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,recordcheck,3)
  149. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:3] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  150. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:20] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  151. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:13] Set("SIP/vitel-inbound-000dd0cb", "RingGroupMethod=ringall") in new stack
  152. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [600@ext-group:14] Macro("SIP/vitel-inbound-000dd0cb", "dial,30,Ttr,101-102-103-104-105-106-107-108-109-110") in new stack
  153. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:1] NoOp("SIP/vitel-inbound-000dd0cb", "Blind Transfer: , Attended Transfer: , User: , Alert Info: external1") in new stack
  154. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:2] Set("SIP/vitel-inbound-000dd0cb", "__CRM_SOURCE=2399615003") in new stack
  155. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:3] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ALERT_INFO=)") in new stack
  156. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:4] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ALERT_INFO=)") in new stack
  157. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:5] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ALERT_INFO=)") in new stack
  158. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:6] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(CHANNEL(musicclass)=ClassicRockStream)") in new stack
  159. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:7] AGI("SIP/vitel-inbound-000dd0cb", "dialparties.agi") in new stack
  160. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  161. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: Starting New Dialparties.agi
  162. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: Caller ID name is '2399615003' number is '2399615003'
  163. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: CW Ignore is:
  164. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: CF Ignore is:
  165. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: CW IN_USE/BUSY is: 1
  166. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:  dialparties.agi: Methodology of ring is  'ringall'
  167. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 101 to extension map
  168. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 102 to extension map
  169. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 103 to extension map
  170. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 104 to extension map
  171. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 105 to extension map
  172. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 106 to extension map
  173. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 107 to extension map
  174. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 108 to extension map
  175. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 109 to extension map
  176. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Added extension 110 to extension map
  177. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 101 cf is disabled
  178. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 102 cf is disabled
  179. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 103 cf is disabled
  180. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 104 cf is disabled
  181. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 105 cf is disabled
  182. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 106 cf is disabled
  183. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 107 cf is disabled
  184. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 108 cf is disabled
  185. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 109 cf is disabled
  186. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 110 cf is disabled
  187. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 101 do not disturb is disabled
  188. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 102 do not disturb is disabled
  189. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 103 do not disturb is disabled
  190. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 104 do not disturb is disabled
  191. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 105 do not disturb is disabled
  192. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 106 do not disturb is disabled
  193. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 107 do not disturb is disabled
  194. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 108 do not disturb is disabled
  195. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 109 do not disturb is disabled
  196. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Extension 110 do not disturb is disabled
  197. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/101 to 2399615003
  198. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/102 to 2399615003
  199. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/103 to 2399615003
  200. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/104 to 2399615003
  201. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/105 to 2399615003
  202. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/106 to 2399615003
  203. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/107 to 2399615003
  204. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/108 to 2399615003
  205. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/109 to 2399615003
  206. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: dbset CALLTRACE/110 to 2399615003
  207. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- dialparties.agi: Filtered ARG3: 101-102-103-104-105-106-107-108-109-110
  208. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] res_agi.c:     -- <SIP/vitel-inbound-000dd0cb>AGI Script dialparties.agi completed, returning 0
  209. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:10] NoOp("SIP/vitel-inbound-000dd0cb", "Returned from dialparties with groups to dial") in new stack
  210. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:11] NoOp("SIP/vitel-inbound-000dd0cb", "ringall array  ") in new stack
  211. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:12] Set("SIP/vitel-inbound-000dd0cb", "__FMGL_DIAL=") in new stack
  212. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:13] Set("SIP/vitel-inbound-000dd0cb", "LOOPCNT=10") in new stack
  213. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:14] Set("SIP/vitel-inbound-000dd0cb", "ITER=1") in new stack
  214. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=101") in new stack
  215. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 101") in new stack
  216. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  217. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  218. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=2") in new stack
  219. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  220. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  221. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=102") in new stack
  222. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 102") in new stack
  223. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  224. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  225. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=3") in new stack
  226. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  227. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  228. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=103") in new stack
  229. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 103") in new stack
  230. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  231. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  232. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=4") in new stack
  233. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  234. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  235. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=104") in new stack
  236. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 104") in new stack
  237. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  238. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  239. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=5") in new stack
  240. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  241. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  242. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=105") in new stack
  243. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 105") in new stack
  244. [2019-10-25 08:46:29] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  245. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  246. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=6") in new stack
  247. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  248. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  249. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=106") in new stack
  250. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 106") in new stack
  251. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  252. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  253. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=7") in new stack
  254. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  255. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  256. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=107") in new stack
  257. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 107") in new stack
  258. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  259. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  260. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=8") in new stack
  261. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  262. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  263. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=108") in new stack
  264. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 108") in new stack
  265. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  266. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  267. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=9") in new stack
  268. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  269. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  270. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=109") in new stack
  271. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 109") in new stack
  272. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  273. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  274. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=10") in new stack
  275. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "1?ndloopbegin") in new stack
  276. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-dial,s,15)
  277. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:15] Set("SIP/vitel-inbound-000dd0cb", "__EXTTOCALL=110") in new stack
  278. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:16] NoOp("SIP/vitel-inbound-000dd0cb", "Working with 110") in new stack
  279. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:17] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  280. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:18] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(HASH(__SIPHEADERS,Alert-Info)=external1;volume=)") in new stack
  281. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:19] Set("SIP/vitel-inbound-000dd0cb", "ITER=11") in new stack
  282. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:20] GotoIf("SIP/vitel-inbound-000dd0cb", "0?ndloopbegin") in new stack
  283. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:21] Macro("SIP/vitel-inbound-000dd0cb", "dial-ringall-predial-hook,") in new stack
  284. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/vitel-inbound-000dd0cb", "") in new stack
  285. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:22] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(ds=SIP/101&SIP/102&SIP/103&SIP/104&SIP/105&SIP/106&SIP/107&SIP/108&SIP/109&SIP/110,30,trM(auto-blkvm)g)") in new stack
  286. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-dial:23] Dial("SIP/vitel-inbound-000dd0cb", "SIP/101&SIP/102&SIP/103&SIP/104&SIP/105&SIP/106&SIP/107&SIP/108&SIP/109&SIP/110,30,trM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
  287. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  288. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  289. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  290. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  291. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  292. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  293. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  294. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  295. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  296. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  297. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  298. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  299. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  300. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  301. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  302. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  303. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  304. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  305. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP TOS bits 184
  306. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] netsock2.c:   == Using SIP RTP CoS mark 5
  307. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/101-000dd0cc Internal Gosub(func-apply-sipheaders,s,1) start
  308. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/101-000dd0cc", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  309. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/101-000dd0cc", "Applying SIP Headers to channel SIP/101-000dd0cc") in new stack
  310. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/101-000dd0cc", "TECH=SIP") in new stack
  311. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/101-000dd0cc", "SIPHEADERKEYS=Alert-Info") in new stack
  312. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/101-000dd0cc", "1") in new stack
  313. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/101-000dd0cc", "sipheader=external1") in new stack
  314. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/101-000dd0cc", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  315. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/101-000dd0cc", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  316. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/101-000dd0cc", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  317. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/101-000dd0cc", "") in new stack
  318. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/101-000dd0cc", "0") in new stack
  319. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/101-000dd0cc", "") in new stack
  320. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/101-000dd0cc'
  321. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/101-000dd0cc Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  322. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/102-000dd0cd Internal Gosub(func-apply-sipheaders,s,1) start
  323. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/102-000dd0cd", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  324. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/102-000dd0cd", "Applying SIP Headers to channel SIP/102-000dd0cd") in new stack
  325. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/102-000dd0cd", "TECH=SIP") in new stack
  326. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/102-000dd0cd", "SIPHEADERKEYS=Alert-Info") in new stack
  327. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/102-000dd0cd", "1") in new stack
  328. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/102-000dd0cd", "sipheader=external1") in new stack
  329. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/102-000dd0cd", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  330. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/102-000dd0cd", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  331. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/102-000dd0cd", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  332. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/102-000dd0cd", "") in new stack
  333. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/102-000dd0cd", "0") in new stack
  334. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/102-000dd0cd", "") in new stack
  335. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/102-000dd0cd'
  336. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/102-000dd0cd Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  337. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/103-000dd0ce Internal Gosub(func-apply-sipheaders,s,1) start
  338. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/103-000dd0ce", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  339. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/103-000dd0ce", "Applying SIP Headers to channel SIP/103-000dd0ce") in new stack
  340. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/103-000dd0ce", "TECH=SIP") in new stack
  341. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/103-000dd0ce", "SIPHEADERKEYS=Alert-Info") in new stack
  342. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/103-000dd0ce", "1") in new stack
  343. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/103-000dd0ce", "sipheader=external1") in new stack
  344. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/103-000dd0ce", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  345. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/103-000dd0ce", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  346. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/103-000dd0ce", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  347. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/103-000dd0ce", "") in new stack
  348. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/103-000dd0ce", "0") in new stack
  349. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/103-000dd0ce", "") in new stack
  350. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/103-000dd0ce'
  351. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/103-000dd0ce Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  352. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/104-000dd0cf Internal Gosub(func-apply-sipheaders,s,1) start
  353. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/104-000dd0cf", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  354. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/104-000dd0cf", "Applying SIP Headers to channel SIP/104-000dd0cf") in new stack
  355. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/104-000dd0cf", "TECH=SIP") in new stack
  356. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/104-000dd0cf", "SIPHEADERKEYS=Alert-Info") in new stack
  357. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/104-000dd0cf", "1") in new stack
  358. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/104-000dd0cf", "sipheader=external1") in new stack
  359. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/104-000dd0cf", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  360. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/104-000dd0cf", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  361. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/104-000dd0cf", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  362. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/104-000dd0cf", "") in new stack
  363. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/104-000dd0cf", "0") in new stack
  364. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/104-000dd0cf", "") in new stack
  365. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/104-000dd0cf'
  366. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/104-000dd0cf Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  367. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/105-000dd0d0 Internal Gosub(func-apply-sipheaders,s,1) start
  368. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/105-000dd0d0", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  369. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/105-000dd0d0", "Applying SIP Headers to channel SIP/105-000dd0d0") in new stack
  370. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/105-000dd0d0", "TECH=SIP") in new stack
  371. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/105-000dd0d0", "SIPHEADERKEYS=Alert-Info") in new stack
  372. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/105-000dd0d0", "1") in new stack
  373. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/105-000dd0d0", "sipheader=external1") in new stack
  374. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/105-000dd0d0", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  375. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/105-000dd0d0", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  376. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/105-000dd0d0", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  377. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/105-000dd0d0", "") in new stack
  378. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/105-000dd0d0", "0") in new stack
  379. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/105-000dd0d0", "") in new stack
  380. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/105-000dd0d0'
  381. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/105-000dd0d0 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  382. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/106-000dd0d1 Internal Gosub(func-apply-sipheaders,s,1) start
  383. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/106-000dd0d1", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  384. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/106-000dd0d1", "Applying SIP Headers to channel SIP/106-000dd0d1") in new stack
  385. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/106-000dd0d1", "TECH=SIP") in new stack
  386. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/106-000dd0d1", "SIPHEADERKEYS=Alert-Info") in new stack
  387. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/106-000dd0d1", "1") in new stack
  388. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/106-000dd0d1", "sipheader=external1") in new stack
  389. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/106-000dd0d1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  390. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/106-000dd0d1", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  391. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/106-000dd0d1", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  392. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/106-000dd0d1", "") in new stack
  393. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/106-000dd0d1", "0") in new stack
  394. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/106-000dd0d1", "") in new stack
  395. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/106-000dd0d1'
  396. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/106-000dd0d1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  397. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/107-000dd0d2 Internal Gosub(func-apply-sipheaders,s,1) start
  398. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/107-000dd0d2", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  399. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/107-000dd0d2", "Applying SIP Headers to channel SIP/107-000dd0d2") in new stack
  400. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/107-000dd0d2", "TECH=SIP") in new stack
  401. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/107-000dd0d2", "SIPHEADERKEYS=Alert-Info") in new stack
  402. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/107-000dd0d2", "1") in new stack
  403. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/107-000dd0d2", "sipheader=external1") in new stack
  404. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/107-000dd0d2", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  405. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/107-000dd0d2", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  406. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/107-000dd0d2", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  407. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/107-000dd0d2", "") in new stack
  408. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/107-000dd0d2", "0") in new stack
  409. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/107-000dd0d2", "") in new stack
  410. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/107-000dd0d2'
  411. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/107-000dd0d2 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  412. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/108-000dd0d3 Internal Gosub(func-apply-sipheaders,s,1) start
  413. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/108-000dd0d3", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  414. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/108-000dd0d3", "Applying SIP Headers to channel SIP/108-000dd0d3") in new stack
  415. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/108-000dd0d3", "TECH=SIP") in new stack
  416. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/108-000dd0d3", "SIPHEADERKEYS=Alert-Info") in new stack
  417. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/108-000dd0d3", "1") in new stack
  418. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/108-000dd0d3", "sipheader=external1") in new stack
  419. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/108-000dd0d3", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  420. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/108-000dd0d3", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  421. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/108-000dd0d3", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  422. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/108-000dd0d3", "") in new stack
  423. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/108-000dd0d3", "0") in new stack
  424. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/108-000dd0d3", "") in new stack
  425. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/108-000dd0d3'
  426. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/108-000dd0d3 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  427. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/109-000dd0d4 Internal Gosub(func-apply-sipheaders,s,1) start
  428. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/109-000dd0d4", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  429. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/109-000dd0d4", "Applying SIP Headers to channel SIP/109-000dd0d4") in new stack
  430. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/109-000dd0d4", "TECH=SIP") in new stack
  431. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/109-000dd0d4", "SIPHEADERKEYS=Alert-Info") in new stack
  432. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/109-000dd0d4", "1") in new stack
  433. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/109-000dd0d4", "sipheader=external1") in new stack
  434. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/109-000dd0d4", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  435. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/109-000dd0d4", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  436. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/109-000dd0d4", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  437. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/109-000dd0d4", "") in new stack
  438. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/109-000dd0d4", "0") in new stack
  439. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/109-000dd0d4", "") in new stack
  440. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/109-000dd0d4'
  441. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/109-000dd0d4 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  442. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/110-000dd0d5 Internal Gosub(func-apply-sipheaders,s,1) start
  443. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:1] ExecIf("SIP/110-000dd0d5", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  444. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:2] NoOp("SIP/110-000dd0d5", "Applying SIP Headers to channel SIP/110-000dd0d5") in new stack
  445. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:3] Set("SIP/110-000dd0d5", "TECH=SIP") in new stack
  446. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:4] Set("SIP/110-000dd0d5", "SIPHEADERKEYS=Alert-Info") in new stack
  447. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/110-000dd0d5", "1") in new stack
  448. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:6] Set("SIP/110-000dd0d5", "sipheader=external1") in new stack
  449. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:7] ExecIf("SIP/110-000dd0d5", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  450. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:8] ExecIf("SIP/110-000dd0d5", "1?Set(sipheader=<http://127.0.0.1>;info=external1)") in new stack
  451. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:9] ExecIf("SIP/110-000dd0d5", "1?SIPAddHeader(Alert-Info:<http://127.0.0.1>;info=external1)") in new stack
  452. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:10] EndWhile("SIP/110-000dd0d5", "") in new stack
  453. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:5] While("SIP/110-000dd0d5", "0") in new stack
  454. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@func-apply-sipheaders:11] Return("SIP/110-000dd0d5", "") in new stack
  455. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/110-000dd0d5'
  456. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/110-000dd0d5 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  457. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/101
  458. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/102
  459. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/103
  460. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/104
  461. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/105
  462. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/106
  463. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/107
  464. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/108
  465. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/109
  466. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- Called SIP/110
  467. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/110-000dd0d5 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  468. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/109-000dd0d4 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  469. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/108-000dd0d3 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  470. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/107-000dd0d2 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  471. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/106-000dd0d1 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  472. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/105-000dd0d0 connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  473. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/104-000dd0cf connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  474. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/103-000dd0ce connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  475. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/102-000dd0cd connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  476. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/101-000dd0cc connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  477. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/104-000dd0cf is ringing
  478. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/102-000dd0cd is ringing
  479. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/107-000dd0d2 is ringing
  480. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/106-000dd0d1 is ringing
  481. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/108-000dd0d3 is ringing
  482. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/101-000dd0cc is ringing
  483. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/103-000dd0ce is ringing
  484. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/105-000dd0d0 is ringing
  485. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/109-000dd0d4 is ringing
  486. [2019-10-25 08:46:30] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/110-000dd0d5 is ringing
  487. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/104-000dd0cf connected line has changed. Saving it until answer for SIP/vitel-inbound-000dd0cb
  488. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_dial.c:     -- SIP/104-000dd0cf answered SIP/vitel-inbound-000dd0cb
  489. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/101-000dd0cc Internal Gosub(crm-hangup,s,1) start
  490. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/101-000dd0cc", "Sending Hangup to CRM") in new stack
  491. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/101-000dd0cc", "HANGUP CAUSE: 26") in new stack
  492. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/101-000dd0cc", "0?Set(__CRM_VOICEMAIL=)") in new stack
  493. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/101-000dd0cc", "MASTER CHANNEL: 1572007590.911606 = 1572007589.911605") in new stack
  494. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/101-000dd0cc", "1?return") in new stack
  495. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  496. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/101-000dd0cc", "") in new stack
  497. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/101-000dd0cc'
  498. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/101-000dd0cc Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  499. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/102-000dd0cd Internal Gosub(crm-hangup,s,1) start
  500. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/102-000dd0cd", "Sending Hangup to CRM") in new stack
  501. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/102-000dd0cd", "HANGUP CAUSE: 26") in new stack
  502. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/102-000dd0cd", "0?Set(__CRM_VOICEMAIL=)") in new stack
  503. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/102-000dd0cd", "MASTER CHANNEL: 1572007590.911607 = 1572007589.911605") in new stack
  504. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/102-000dd0cd", "1?return") in new stack
  505. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  506. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/102-000dd0cd", "") in new stack
  507. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/102-000dd0cd'
  508. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/102-000dd0cd Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  509. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/103-000dd0ce Internal Gosub(crm-hangup,s,1) start
  510. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/103-000dd0ce", "Sending Hangup to CRM") in new stack
  511. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/103-000dd0ce", "HANGUP CAUSE: 26") in new stack
  512. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/103-000dd0ce", "0?Set(__CRM_VOICEMAIL=)") in new stack
  513. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/103-000dd0ce", "MASTER CHANNEL: 1572007590.911608 = 1572007589.911605") in new stack
  514. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/103-000dd0ce", "1?return") in new stack
  515. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  516. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/103-000dd0ce", "") in new stack
  517. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/103-000dd0ce'
  518. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/103-000dd0ce Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  519. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/105-000dd0d0 Internal Gosub(crm-hangup,s,1) start
  520. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/105-000dd0d0", "Sending Hangup to CRM") in new stack
  521. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/105-000dd0d0", "HANGUP CAUSE: 26") in new stack
  522. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/105-000dd0d0", "0?Set(__CRM_VOICEMAIL=)") in new stack
  523. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/105-000dd0d0", "MASTER CHANNEL: 1572007590.911610 = 1572007589.911605") in new stack
  524. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/105-000dd0d0", "1?return") in new stack
  525. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  526. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/105-000dd0d0", "") in new stack
  527. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/105-000dd0d0'
  528. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/105-000dd0d0 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  529. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/106-000dd0d1 Internal Gosub(crm-hangup,s,1) start
  530. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/106-000dd0d1", "Sending Hangup to CRM") in new stack
  531. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/106-000dd0d1", "HANGUP CAUSE: 26") in new stack
  532. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/106-000dd0d1", "0?Set(__CRM_VOICEMAIL=)") in new stack
  533. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/106-000dd0d1", "MASTER CHANNEL: 1572007590.911611 = 1572007589.911605") in new stack
  534. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/106-000dd0d1", "1?return") in new stack
  535. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  536. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/106-000dd0d1", "") in new stack
  537. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/106-000dd0d1'
  538. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/106-000dd0d1 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  539. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/107-000dd0d2 Internal Gosub(crm-hangup,s,1) start
  540. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/107-000dd0d2", "Sending Hangup to CRM") in new stack
  541. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/107-000dd0d2", "HANGUP CAUSE: 26") in new stack
  542. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/107-000dd0d2", "0?Set(__CRM_VOICEMAIL=)") in new stack
  543. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/107-000dd0d2", "MASTER CHANNEL: 1572007590.911612 = 1572007589.911605") in new stack
  544. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/107-000dd0d2", "1?return") in new stack
  545. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  546. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/107-000dd0d2", "") in new stack
  547. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/107-000dd0d2'
  548. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/107-000dd0d2 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  549. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/108-000dd0d3 Internal Gosub(crm-hangup,s,1) start
  550. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/108-000dd0d3", "Sending Hangup to CRM") in new stack
  551. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/108-000dd0d3", "HANGUP CAUSE: 26") in new stack
  552. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/108-000dd0d3", "0?Set(__CRM_VOICEMAIL=)") in new stack
  553. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/108-000dd0d3", "MASTER CHANNEL: 1572007590.911613 = 1572007589.911605") in new stack
  554. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/108-000dd0d3", "1?return") in new stack
  555. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  556. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/108-000dd0d3", "") in new stack
  557. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/108-000dd0d3'
  558. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/108-000dd0d3 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  559. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/109-000dd0d4 Internal Gosub(crm-hangup,s,1) start
  560. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/109-000dd0d4", "Sending Hangup to CRM") in new stack
  561. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/109-000dd0d4", "HANGUP CAUSE: 26") in new stack
  562. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/109-000dd0d4", "0?Set(__CRM_VOICEMAIL=)") in new stack
  563. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/109-000dd0d4", "MASTER CHANNEL: 1572007590.911614 = 1572007589.911605") in new stack
  564. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/109-000dd0d4", "1?return") in new stack
  565. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  566. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/109-000dd0d4", "") in new stack
  567. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/109-000dd0d4'
  568. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/109-000dd0d4 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  569. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/110-000dd0d5 Internal Gosub(crm-hangup,s,1) start
  570. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/110-000dd0d5", "Sending Hangup to CRM") in new stack
  571. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/110-000dd0d5", "HANGUP CAUSE: 26") in new stack
  572. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/110-000dd0d5", "0?Set(__CRM_VOICEMAIL=)") in new stack
  573. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/110-000dd0d5", "MASTER CHANNEL: 1572007590.911615 = 1572007589.911605") in new stack
  574. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/110-000dd0d5", "1?return") in new stack
  575. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  576. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/110-000dd0d5", "") in new stack
  577. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal, 600, 1) exited non-zero on 'SIP/110-000dd0d5'
  578. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/110-000dd0d5 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  579. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:1] Set("SIP/104-000dd0cf", "__MACRO_RESULT=") in new stack
  580. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:2] Set("SIP/104-000dd0cf", "CFIGNORE=") in new stack
  581. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:3] Set("SIP/104-000dd0cf", "MASTER_CHANNEL(CFIGNORE)=") in new stack
  582. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:4] Set("SIP/104-000dd0cf", "FORWARD_CONTEXT=from-internal") in new stack
  583. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:5] Set("SIP/104-000dd0cf", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
  584. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:6] Macro("SIP/104-000dd0cf", "blkvm-clr,") in new stack
  585. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-clr:1] Set("SIP/104-000dd0cf", "SHARED(BLKVM,SIP/vitel-inbound-000dd0cb)=") in new stack
  586. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-clr:2] Set("SIP/104-000dd0cf", "GOSUB_RETVAL=") in new stack
  587. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/104-000dd0cf", "") in new stack
  588. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:7] ExecIf("SIP/104-000dd0cf", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=104)") in new stack
  589. [2019-10-25 08:46:36] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-auto-blkvm:8] ExecIf("SIP/104-000dd0cf", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Tara Snyder)") in new stack
  590. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] res_musiconhold.c:     -- Started music on hold, class 'ClassicRockStream', on channel 'SIP/vitel-inbound-000dd0cb'
  591. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] res_musiconhold.c:     -- Stopped music on hold on SIP/vitel-inbound-000dd0cb
  592. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/104-000dd0cf Internal Gosub(crm-hangup,s,1) start
  593. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:1] NoOp("SIP/104-000dd0cf", "Sending Hangup to CRM") in new stack
  594. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:2] NoOp("SIP/104-000dd0cf", "HANGUP CAUSE: 16") in new stack
  595. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:3] ExecIf("SIP/104-000dd0cf", "0?Set(__CRM_VOICEMAIL=)") in new stack
  596. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:4] NoOp("SIP/104-000dd0cf", "MASTER CHANNEL: 1572007590.911609 = 1572007589.911605") in new stack
  597. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:5] GotoIf("SIP/104-000dd0cf", "1?return") in new stack
  598. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (crm-hangup,s,8)
  599. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@crm-hangup:8] Return("SIP/104-000dd0cf", "") in new stack
  600. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] app_stack.c:   == Spawn extension (from-internal-xfer, s, 1) exited non-zero on 'SIP/104-000dd0cf'
  601. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] app_stack.c:     -- SIP/104-000dd0cf Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  602. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] app_macro.c:   == Spawn extension (from-internal-xfer, 72, 1) exited non-zero on 'SIP/vitel-inbound-000dd0cb' in macro 'dial'
  603. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:   == Spawn extension (from-internal-xfer, 72, 1) exited non-zero on 'SIP/vitel-inbound-000dd0cb'
  604. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [72@from-internal-xfer:1] Macro("SIP/vitel-inbound-000dd0cb", "parked-call,72,default") in new stack
  605. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:1] Macro("SIP/vitel-inbound-000dd0cb", "user-callerid,") in new stack
  606. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:1] Set("SIP/vitel-inbound-000dd0cb", "TOUCH_MONITOR=1572007589.911605") in new stack
  607. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:2] Set("SIP/vitel-inbound-000dd0cb", "AMPUSER=2399615003") in new stack
  608. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:3] GotoIf("SIP/vitel-inbound-000dd0cb", "0?report") in new stack
  609. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:4] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(REALCALLERIDNUM=2399615003)") in new stack
  610. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:5] Set("SIP/vitel-inbound-000dd0cb", "AMPUSER=") in new stack
  611. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:6] GotoIf("SIP/vitel-inbound-000dd0cb", "0?limit") in new stack
  612. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:7] Set("SIP/vitel-inbound-000dd0cb", "AMPUSERCIDNAME=") in new stack
  613. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:8] ExecIf("SIP/vitel-inbound-000dd0cb", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  614. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:9] GotoIf("SIP/vitel-inbound-000dd0cb", "1?report") in new stack
  615. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,16)
  616. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:16] NoOp("SIP/vitel-inbound-000dd0cb", "Macro Depth is 2") in new stack
  617. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:17] GotoIf("SIP/vitel-inbound-000dd0cb", "1?report2:macroerror") in new stack
  618. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,18)
  619. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:18] GotoIf("SIP/vitel-inbound-000dd0cb", "0?continue") in new stack
  620. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:19] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  621. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:20] Set("SIP/vitel-inbound-000dd0cb", "__TTL=63") in new stack
  622. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:21] GotoIf("SIP/vitel-inbound-000dd0cb", "1?continue") in new stack
  623. [2019-10-25 08:46:52] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-user-callerid,s,37)
  624. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:37] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(number)=2399615003") in new stack
  625. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:38] Set("SIP/vitel-inbound-000dd0cb", "CALLERID(name)=2399615003") in new stack
  626. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:39] GotoIf("SIP/vitel-inbound-000dd0cb", "0?cnum") in new stack
  627. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:40] Set("SIP/vitel-inbound-000dd0cb", "CDR(cnam)=2399615003") in new stack
  628. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:41] Set("SIP/vitel-inbound-000dd0cb", "CDR(cnum)=2399615003") in new stack
  629. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-user-callerid:42] Set("SIP/vitel-inbound-000dd0cb", "CHANNEL(language)=en") in new stack
  630. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:2] Gosub("SIP/vitel-inbound-000dd0cb", "sub-record-check,s,1(parking,,)") in new stack
  631. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:1] GotoIf("SIP/vitel-inbound-000dd0cb", "10?initialized") in new stack
  632. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,s,10)
  633. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:10] NoOp("SIP/vitel-inbound-000dd0cb", "Recordings initialized") in new stack
  634. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:11] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(ARG3=dontcare)") in new stack
  635. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:12] Set("SIP/vitel-inbound-000dd0cb", "REC_POLICY_MODE_SAVE=") in new stack
  636. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:13] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(REC_STATUS=NO)") in new stack
  637. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:14] GotoIf("SIP/vitel-inbound-000dd0cb", "7?checkaction") in new stack
  638. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,s,17)
  639. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@sub-record-check:17] GotoIf("SIP/vitel-inbound-000dd0cb", "1?sub-record-check,parking,1") in new stack
  640. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,parking,1)
  641. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:1] NoOp("SIP/vitel-inbound-000dd0cb", "User  picked up a parked call") in new stack
  642. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:2] Set("SIP/vitel-inbound-000dd0cb", "USER=") in new stack
  643. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:3] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(USER=unknown)") in new stack
  644. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:4] Set("SIP/vitel-inbound-000dd0cb", "RECMODE=") in new stack
  645. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:5] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(RECMODE=dontcare)") in new stack
  646. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:6] Gosub("SIP/vitel-inbound-000dd0cb", "recordcheck,1(dontcare,parked,unknown)") in new stack
  647. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/vitel-inbound-000dd0cb", "Starting recording check against dontcare") in new stack
  648. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:2] Goto("SIP/vitel-inbound-000dd0cb", "dontcare") in new stack
  649. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (sub-record-check,recordcheck,3)
  650. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [recordcheck@sub-record-check:3] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  651. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [parking@sub-record-check:7] Return("SIP/vitel-inbound-000dd0cb", "") in new stack
  652. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:3] NoOp("SIP/vitel-inbound-000dd0cb", "PARKRETURNTO: ") in new stack
  653. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:4] GotoIf("SIP/vitel-inbound-000dd0cb", "0?backtosender") in new stack
  654. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:5] GotoIf("SIP/vitel-inbound-000dd0cb", "1?attemptpark") in new stack
  655. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-parked-call,s,24)
  656. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:24] NoOp("SIP/vitel-inbound-000dd0cb", "User: "2399615003" <2399615003> attempting to Park into slot 72") in new stack
  657. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:25] NoOp("SIP/vitel-inbound-000dd0cb", "Blind Transfer: SIP/104-000dd0cf, Attended Transfer: ") in new stack
  658. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:26] NoOp("SIP/vitel-inbound-000dd0cb", "1") in new stack
  659. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:27] GotoIf("SIP/vitel-inbound-000dd0cb", "1?parkit") in new stack
  660. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-parked-call,s,29)
  661. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:29] Set("SIP/vitel-inbound-000dd0cb", "PARKINGEXTEN=72") in new stack
  662. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:30] ExecIf("SIP/vitel-inbound-000dd0cb", "1?Set(SHARED(PARKRETURNTO,SIP/vitel-inbound-000dd0cb)=SIP/104):Set(SHARED(PARKRETURNTO,SIP/vitel-inbound-000dd0cb)=)") in new stack
  663. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:31] NoOp("SIP/vitel-inbound-000dd0cb", "PARKRETURNTO: SIP/104") in new stack
  664. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-parked-call:32] Park("SIP/vitel-inbound-000dd0cb", ",macro-parked-call,s,200,s,default") in new stack
  665. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] features.c:   == Parked SIP/vitel-inbound-000dd0cb on 72 (lot default). Will timeout back to extension [macro-parked-call] s, 200 in 240 seconds
  666. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Added extension '72' priority 1 to parkedcalls
  667. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] res_musiconhold.c:     -- Started music on hold, class 'ClassicRockStream', on channel 'SIP/vitel-inbound-000dd0cb'
  668. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] app_macro.c:   == Spawn extension (macro-parked-call, s, 1) exited non-zero on 'Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>' in macro 'parked-call'
  669. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:   == Spawn extension (from-internal-xfer, 72, 1) exited non-zero on 'Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>'
  670. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [h@from-internal-xfer:1] Macro("Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>", "hangupcall") in new stack
  671. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-hangupcall:1] ExecIf("Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>", "0?Set(CDR(recordingfile)=.wav)") in new stack
  672. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-hangupcall:2] GotoIf("Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>", "1?theend") in new stack
  673. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Goto (macro-hangupcall,s,4)
  674. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-hangupcall:4] ExecIf("Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>", "0?Set(CDR(recordingfile)=)") in new stack
  675. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:     -- Executing [s@macro-hangupcall:5] Hangup("Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>", "") in new stack
  676. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] app_macro.c:   == Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>' in macro 'hangupcall'
  677. [2019-10-25 08:46:53] VERBOSE[5641][C-000a5ff1] pbx.c:   == Spawn extension (from-internal-xfer, h, 1) exited non-zero on 'Parked/SIP/vitel-inbound-000dd0cb<ZOMBIE>'
  678.  

Reply to "Automatic Pastebin from FreePBX Distro 6"

Here you can reply to the paste above

captcha