Re: FollowMe: Working extension

From SilkBC, 1 Year ago, written in Plain Text, viewed 3 times. This paste will join the choir invisible in 1 Second. This paste is a reply to FollowMe: Working extension from SilkBC - view diff
URL https://pastebin.freepbx.org/view/6fdaf2c0 Embed
Download Paste or View Raw
  1. [2018-08-10 23:46:57] VERBOSE[18059][C-0000b182] netsock2.c: Using SIP RTP TOS bits 184
  2. [2018-08-10 23:46:57] VERBOSE[18059][C-0000b182] netsock2.c: Using SIP RTP CoS mark 5
  3. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk-sip-OneConnect-SIP-YVR1:1] Set("SIP/OneConnect-SIP-YVR1-0001435e", "GROUP()=OUT_3") in new stack
  4. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk-sip-OneConnect-SIP-YVR1:2] Goto("SIP/OneConnect-SIP-YVR1-0001435e", "from-trunk,6046992271,1") in new stack
  5. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (from-trunk,6046992271,1)
  6. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:1] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__DIRECTION=INBOUND") in new stack
  7. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:2] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "sub-record-check,s,1(in,6046992271,dontcare)") in new stack
  8. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?initialized") in new stack
  9. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__REC_STATUS=INITIALIZED") in new stack
  10. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:3] Set("SIP/OneConnect-SIP-YVR1-0001435e", "NOW=1533970017") in new stack
  11. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:4] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__DAY=10") in new stack
  12. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:5] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__MONTH=08") in new stack
  13. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:6] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__YEAR=2018") in new stack
  14. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:7] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__TIMESTR=20180810-234657") in new stack
  15. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:8] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__FROMEXTEN=unknown") in new stack
  16. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:9] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__MON_FMT=wav") in new stack
  17. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Recordings initialized") in new stack
  18. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(ARG3=dontcare)") in new stack
  19. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:12] Set("SIP/OneConnect-SIP-YVR1-0001435e", "REC_POLICY_MODE_SAVE=") in new stack
  20. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(REC_STATUS=NO)") in new stack
  21. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "2?checkaction") in new stack
  22. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,s,17)
  23. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?sub-record-check,in,1") in new stack
  24. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,in,1)
  25. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Inbound Recording Check to 6046992271") in new stack
  26. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [in@sub-record-check:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "FROMEXTEN=unknown") in new stack
  27. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "10?Set(FROMEXTEN=7788190474)") in new stack
  28. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "recordcheck,1(dontcare,in,6046992271)") in new stack
  29. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Starting recording check against dontcare") in new stack
  30. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/OneConnect-SIP-YVR1-0001435e", "dontcare") in new stack
  31. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  32. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  33. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [in@sub-record-check:5] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  34. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:3] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__FROM_DID=6046992271") in new stack
  35. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:4] Set("SIP/OneConnect-SIP-YVR1-0001435e", "returnhere=1") in new stack
  36. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:5] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "app-blacklist-check,s,1()") in new stack
  37. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?blacklisted") in new stack
  38. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLED_BLACKLIST=1") in new stack
  39. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  40. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:6] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CDR(did)=6046992271") in new stack
  41. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:7] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?") in new stack
  42. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:8] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0 ?Set(CALLERID(name)=7788190474)") in new stack
  43. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:9] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CHANNEL(musicclass)=commercial-shawsabey-01") in new stack
  44. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:10] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__MOHCLASS=commercial-shawsabey-01") in new stack
  45. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:11] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__REVERSAL_REJECT=FALSE") in new stack
  46. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:12] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?post-reverse-charge") in new stack
  47. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (from-trunk,6046992271,14)
  48. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:14] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  49. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:15] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  50. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:16] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  51. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:17] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLERID(name-pres)=allowed_not_screened") in new stack
  52. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:18] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLERID(num-pres)=allowed_not_screened") in new stack
  53. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:19] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "CallerID Entry Point") in new stack
  54. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:20] Set("SIP/OneConnect-SIP-YVR1-0001435e", "FAX_DEST=ext-fax^224^1") in new stack
  55. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:21] Set("SIP/OneConnect-SIP-YVR1-0001435e", "FAXOPT(faxdetect)=yes") in new stack
  56. [2018-08-10 23:46:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:22] Answer("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  57. [2018-08-10 23:46:58] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:23] PlayTones("SIP/OneConnect-SIP-YVR1-0001435e", "ring") in new stack
  58. [2018-08-10 23:46:58] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:24] Wait("SIP/OneConnect-SIP-YVR1-0001435e", "4") in new stack
  59. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:25] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CRM_DIRECTION=INBOUND") in new stack
  60. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:26] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CRM_SOURCE=7788190474") in new stack
  61. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:27] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CRM_LINKEDID=1533970017.175991") in new stack
  62. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:28] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  63. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [6046992271@from-trunk:29] Goto("SIP/OneConnect-SIP-YVR1-0001435e", "from-did-direct,999,1") in new stack
  64. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (from-did-direct,999,1)
  65. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@from-did-direct:1] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?ext-local,999,1:followme-check,999,1") in new stack
  66. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-check,999,1)
  67. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-check:1] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "followme-sub,999,1()") in new stack
  68. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:1] Macro("SIP/OneConnect-SIP-YVR1-0001435e", "user-callerid,") in new stack
  69. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/OneConnect-SIP-YVR1-0001435e", "TOUCH_MONITOR=1533970017.175991") in new stack
  70. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "AMPUSER=7788190474") in new stack
  71. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?report") in new stack
  72. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(REALCALLERIDNUM=7788190474)") in new stack
  73. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/OneConnect-SIP-YVR1-0001435e", "AMPUSER=") in new stack
  74. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?limit") in new stack
  75. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/OneConnect-SIP-YVR1-0001435e", "AMPUSERCIDNAME=") in new stack
  76. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  77. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?report") in new stack
  78. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,16)
  79. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:16] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Macro Depth is 1") in new stack
  80. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?report2:macroerror") in new stack
  81. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,18)
  82. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?continue") in new stack
  83. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  84. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:20] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__TTL=64") in new stack
  85. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:21] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?continue") in new stack
  86. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,37)
  87. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:37] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLERID(number)=7788190474") in new stack
  88. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:38] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLERID(name)=7788190474") in new stack
  89. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?cnum") in new stack
  90. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:40] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CDR(cnam)=7788190474") in new stack
  91. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:41] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CDR(cnum)=7788190474") in new stack
  92. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-user-callerid:42] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CHANNEL(language)=en") in new stack
  93. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "DIAL_OPTIONS=trI") in new stack
  94. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:3] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CONNECTEDLINE(num,i)=999") in new stack
  95. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:4] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "sub-presencestate-display,s,1(999)") in new stack
  96. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-presencestate-display:1] Goto("SIP/OneConnect-SIP-YVR1-0001435e", "state-available,1") in new stack
  97. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-presencestate-display,state-available,1)
  98. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [state-available@sub-presencestate-display:1] Set("SIP/OneConnect-SIP-YVR1-0001435e", "PRESENCESTATE_DISPLAY=(Available)") in new stack
  99. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [state-available@sub-presencestate-display:2] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  100. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:5] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CONNECTEDLINE(name)=ITG Test(Available)") in new stack
  101. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:6] Set("SIP/OneConnect-SIP-YVR1-0001435e", "FM_DIALSTATUS=NOT_INUSE") in new stack
  102. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:7] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__EXTTOCALL=999") in new stack
  103. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:8] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__PICKUPMARK=999") in new stack
  104. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:9] Macro("SIP/OneConnect-SIP-YVR1-0001435e", "blkvm-setifempty,") in new stack
  105. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?init") in new stack
  106. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
  107. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__BLKVM_CHANNEL=SIP/OneConnect-SIP-YVR1-0001435e") in new stack
  108. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/OneConnect-SIP-YVR1-0001435e", "SHARED(BLKVM,SIP/OneConnect-SIP-YVR1-0001435e)=TRUE") in new stack
  109. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/OneConnect-SIP-YVR1-0001435e", "GOSUB_RETVAL=TRUE") in new stack
  110. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  111. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:10] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?skipov") in new stack
  112. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,13)
  113. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:13] Set("SIP/OneConnect-SIP-YVR1-0001435e", "RRNODEST=") in new stack
  114. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:14] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__NODEST=999") in new stack
  115. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:15] GosubIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?sub-fmsetcid,s,1()") in new stack
  116. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:16] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?skipprepend") in new stack
  117. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,18)
  118. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:18] Set("SIP/OneConnect-SIP-YVR1-0001435e", "RecordMethod=Group") in new stack
  119. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:19] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "sub-record-check,s,1(exten,999,)") in new stack
  120. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "10?initialized") in new stack
  121. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,s,10)
  122. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Recordings initialized") in new stack
  123. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(ARG3=dontcare)") in new stack
  124. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:12] Set("SIP/OneConnect-SIP-YVR1-0001435e", "REC_POLICY_MODE_SAVE=") in new stack
  125. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(REC_STATUS=NO)") in new stack
  126. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "5?checkaction") in new stack
  127. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,s,17)
  128. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?sub-record-check,exten,1") in new stack
  129. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,exten,1)
  130. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Exten Recording Check between 7788190474 and 999") in new stack
  131. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLTYPE=external") in new stack
  132. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:3] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(CALLTYPE=)") in new stack
  133. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:4] Set("SIP/OneConnect-SIP-YVR1-0001435e", "CALLEE=dontcare") in new stack
  134. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:5] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(CALLEE=dontcare)") in new stack
  135. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:6] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?callee") in new stack
  136. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,exten,11)
  137. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:11] Gosub("SIP/OneConnect-SIP-YVR1-0001435e", "recordcheck,1(dontcare,external,999)") in new stack
  138. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Starting recording check against dontcare") in new stack
  139. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/OneConnect-SIP-YVR1-0001435e", "dontcare") in new stack
  140. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  141. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  142. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [exten@sub-record-check:12] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  143. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:20] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?skipdring") in new stack
  144. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,23)
  145. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:23] Set("SIP/OneConnect-SIP-YVR1-0001435e", "STRATEGY=ringallv2-prim") in new stack
  146. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:24] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__RVOL=") in new stack
  147. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:25] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?skipsimple") in new stack
  148. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,28)
  149. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:28] Set("SIP/OneConnect-SIP-YVR1-0001435e", "RingGroupMethod=ringallv2-prim") in new stack
  150. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:29] Set("SIP/OneConnect-SIP-YVR1-0001435e", "_FMGRP=999") in new stack
  151. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:30] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?DIALGRP") in new stack
  152. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,34)
  153. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:34] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(DOPTS=trI):Set(DOPTS=m(Ring)tI)") in new stack
  154. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:35] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?doconfirm") in new stack
  155. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:36] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?ringallv21") in new stack
  156. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (followme-sub,999,39)
  157. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [999@followme-sub:39] Macro("SIP/OneConnect-SIP-YVR1-0001435e", "dial,78,trI,5555551234#") in new stack
  158. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  159. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:2] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CRM_SOURCE=7788190474") in new stack
  160. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(ALERT_INFO=)") in new stack
  161. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(ALERT_INFO=)") in new stack
  162. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(ALERT_INFO=)") in new stack
  163. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?Set(CHANNEL(musicclass)=commercial-shawsabey-01)") in new stack
  164. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:7] AGI("SIP/OneConnect-SIP-YVR1-0001435e", "dialparties.agi") in new stack
  165. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  166. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Starting New Dialparties.agi
  167. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Caller ID name is '7788190474' number is '7788190474'
  168. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: CW Ignore is:
  169. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: CF Ignore is:
  170. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
  171. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Methodology of ring is  'ringallv2-prim'
  172. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Added extension 5555551234# to extension map
  173. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Extension 999 cf is disabled
  174. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Extension 5555551234# cf is disabled
  175. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Extension 999 do not disturb is disabled
  176. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
  177. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Extension 999 has ExtensionState: 0
  178. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: dbset CALLTRACE/999 to 7788190474
  179. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: Filtered ARG3: 999-5555551234
  180. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: dialparties.agi: RING ALL V2 : 5555551234#
  181. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] res_agi.c: <SIP/OneConnect-SIP-YVR1-0001435e>AGI Script dialparties.agi completed, returning 0
  182. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:10] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Returned from dialparties with groups to dial") in new stack
  183. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:11] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "ringall array 5555551234# ") in new stack
  184. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:12] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__FMGL_DIAL=5555551234#") in new stack
  185. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:13] Set("SIP/OneConnect-SIP-YVR1-0001435e", "LOOPCNT=2") in new stack
  186. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:14] Set("SIP/OneConnect-SIP-YVR1-0001435e", "ITER=1") in new stack
  187. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:15] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__EXTTOCALL=999") in new stack
  188. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Working with 999") in new stack
  189. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  190. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  191. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:19] Set("SIP/OneConnect-SIP-YVR1-0001435e", "ITER=2") in new stack
  192. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "1?ndloopbegin") in new stack
  193. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (macro-dial,s,15)
  194. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:15] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__EXTTOCALL=5555551234") in new stack
  195. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Working with 5555551234") in new stack
  196. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  197. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  198. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:19] Set("SIP/OneConnect-SIP-YVR1-0001435e", "ITER=3") in new stack
  199. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?ndloopbegin") in new stack
  200. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:21] Macro("SIP/OneConnect-SIP-YVR1-0001435e", "dial-ringall-predial-hook,") in new stack
  201. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  202. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:22] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(ds=Local/FMPR-999@from-internal&Local/FMGL-5555551234#@from-internal,78,trIM(auto-blkvm)g)") in new stack
  203. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-dial:23] Dial("SIP/OneConnect-SIP-YVR1-0001435e", "Local/FMPR-999@from-internal&Local/FMGL-5555551234#@from-internal,78,trIM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
  204. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMPR-999@from-internal-00004792;1 Internal Gosub(func-apply-sipheaders,s,1) start
  205. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("Local/FMPR-999@from-internal-00004792;1", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  206. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/FMPR-999@from-internal-00004792;1", "Applying SIP Headers to channel") in new stack
  207. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/FMPR-999@from-internal-00004792;1", "SIPHEADERKEYS=") in new stack
  208. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/FMPR-999@from-internal-00004792;1", "0?Set(Rheader=1)") in new stack
  209. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/FMPR-999@from-internal-00004792;1", "0") in new stack
  210. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_while.c: Jumping to priority 9
  211. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/FMPR-999@from-internal-00004792;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  212. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/FMPR-999@from-internal-00004792;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
  213. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/FMPR-999@from-internal-00004792;1", "") in new stack
  214. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Spawn extension (from-internal, 999, 1) exited non-zero on 'Local/FMPR-999@from-internal-00004792;1'
  215. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMPR-999@from-internal-00004792;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  216. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMGL-5555551234#@from-internal-00004793;1 Internal Gosub(func-apply-sipheaders,s,1) start
  217. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  218. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/FMGL-5555551234#@from-internal-00004793;1", "Applying SIP Headers to channel") in new stack
  219. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "SIPHEADERKEYS=") in new stack
  220. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(Rheader=1)") in new stack
  221. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/FMGL-5555551234#@from-internal-00004793;1", "0") in new stack
  222. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_while.c: Jumping to priority 9
  223. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  224. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
  225. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/FMGL-5555551234#@from-internal-00004793;1", "") in new stack
  226. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Spawn extension (from-internal, 999, 1) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;1'
  227. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMGL-5555551234#@from-internal-00004793;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  228. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_dial.c: Called Local/FMPR-999@from-internal
  229. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:1] Set("Local/FMPR-999@from-internal-00004792;2", "CDR_PROP(disable)=true") in new stack
  230. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:2] Set("Local/FMPR-999@from-internal-00004792;2", "RingGroupMethod=") in new stack
  231. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:3] Set("Local/FMPR-999@from-internal-00004792;2", "USE_CONFIRMATION=") in new stack
  232. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:4] Set("Local/FMPR-999@from-internal-00004792;2", "RINGGROUP_INDEX=") in new stack
  233. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:5] Macro("Local/FMPR-999@from-internal-00004792;2", "simple-dial,999,18") in new stack
  234. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_dial.c: Called Local/FMGL-5555551234#@from-internal
  235. [2018-08-10 23:47:02] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:1] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "CDR_PROP(disable)=true") in new stack
  236. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:1] Set("Local/FMPR-999@from-internal-00004792;2", "__EXTTOCALL=999") in new stack
  237. [2018-08-10 23:47:02] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:2] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "DIALNUMS=5555551234#") in new stack
  238. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:2] Set("Local/FMPR-999@from-internal-00004792;2", "RT=18") in new stack
  239. [2018-08-10 23:47:02] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:3] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "ENDLOOP=1533970040") in new stack
  240. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:3] Set("Local/FMPR-999@from-internal-00004792;2", "CFUEXT=") in new stack
  241. [2018-08-10 23:47:02] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  242. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:4] Set("Local/FMPR-999@from-internal-00004792;2", "CFBEXT=") in new stack
  243. [2018-08-10 23:47:02] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  244. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:5] Set("Local/FMPR-999@from-internal-00004792;2", "CWI_TMP=") in new stack
  245. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:6] Macro("Local/FMPR-999@from-internal-00004792;2", "dial-one,18,tr,999") in new stack
  246. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:1] Set("Local/FMPR-999@from-internal-00004792;2", "DEXTEN=999") in new stack
  247. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:2] Set("Local/FMPR-999@from-internal-00004792;2", "__CRM_SOURCE=7788190474") in new stack
  248. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:3] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(__EXTTOCALL=999)") in new stack
  249. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:4] Set("Local/FMPR-999@from-internal-00004792;2", "DIALSTATUS_CW=") in new stack
  250. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:5] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?screen,1()") in new stack
  251. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:6] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?cf,1()") in new stack
  252. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:7] GotoIf("Local/FMPR-999@from-internal-00004792;2", "1?skip1") in new stack
  253. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-dial-one,s,10)
  254. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:10] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?nodial") in new stack
  255. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:11] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?continue") in new stack
  256. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:12] Set("Local/FMPR-999@from-internal-00004792;2", "EXTHASCW=ENABLED") in new stack
  257. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:13] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?next1:cwinusebusy") in new stack
  258. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-dial-one,s,25)
  259. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:25] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?next3:continue") in new stack
  260. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-dial-one,s,27)
  261. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:27] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?nodial") in new stack
  262. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:28] GosubIf("Local/FMPR-999@from-internal-00004792;2", "1?dstring,1():dlocal,1()") in new stack
  263. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:1] Set("Local/FMPR-999@from-internal-00004792;2", "DSTRING=") in new stack
  264. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:2] Set("Local/FMPR-999@from-internal-00004792;2", "DEVICES=999") in new stack
  265. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Return()") in new stack
  266. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(DEVICES=99)") in new stack
  267. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:5] Set("Local/FMPR-999@from-internal-00004792;2", "LOOPCNT=1") in new stack
  268. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:6] Set("Local/FMPR-999@from-internal-00004792;2", "ITER=1") in new stack
  269. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:7] Set("Local/FMPR-999@from-internal-00004792;2", "THISDIAL=SIP/999") in new stack
  270. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("Local/FMPR-999@from-internal-00004792;2", "1?zap2dahdi,1()") in new stack
  271. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Return()") in new stack
  272. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("Local/FMPR-999@from-internal-00004792;2", "NEWDIAL=") in new stack
  273. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("Local/FMPR-999@from-internal-00004792;2", "LOOPCNT2=1") in new stack
  274. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("Local/FMPR-999@from-internal-00004792;2", "ITER2=1") in new stack
  275. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("Local/FMPR-999@from-internal-00004792;2", "THISPART2=SIP/999") in new stack
  276. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(THISPART2=DAHDI/999)") in new stack
  277. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("Local/FMPR-999@from-internal-00004792;2", "NEWDIAL=SIP/999&") in new stack
  278. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("Local/FMPR-999@from-internal-00004792;2", "ITER2=2") in new stack
  279. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?begin2") in new stack
  280. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("Local/FMPR-999@from-internal-00004792;2", "THISDIAL=SIP/999") in new stack
  281. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  282. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("Local/FMPR-999@from-internal-00004792;2", "1?docheck") in new stack
  283. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-dial-one,dstring,14)
  284. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?skipset") in new stack
  285. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:15] Set("Local/FMPR-999@from-internal-00004792;2", "DSTRING=SIP/999&") in new stack
  286. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:16] Set("Local/FMPR-999@from-internal-00004792;2", "ITER=2") in new stack
  287. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?begin") in new stack
  288. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Return()") in new stack
  289. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:19] Set("Local/FMPR-999@from-internal-00004792;2", "DSTRING=SIP/999") in new stack
  290. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [dstring@macro-dial-one:20] Return("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  291. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:29] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?nodial") in new stack
  292. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:30] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?skiptrace") in new stack
  293. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:31] GosubIf("Local/FMPR-999@from-internal-00004792;2", "1?ctset,1():ctclear,1()") in new stack
  294. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [ctset@macro-dial-one:1] Set("Local/FMPR-999@from-internal-00004792;2", "DB(CALLTRACE/999)=7788190474") in new stack
  295. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [ctset@macro-dial-one:2] Return("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  296. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:32] Set("Local/FMPR-999@from-internal-00004792;2", "D_OPTIONS=trM(auto-blkvm)") in new stack
  297. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:33] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  298. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:34] NoOp("Local/FMPR-999@from-internal-00004792;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  299. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:35] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(ALERT_INFO=)") in new stack
  300. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:36] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(ALERT_INFO=)") in new stack
  301. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:37] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(ALERT_INFO=)") in new stack
  302. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:38] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  303. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:39] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
  304. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:40] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
  305. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:41] ExecIf("Local/FMPR-999@from-internal-00004792;2", "1?Set(CHANNEL(musicclass)=commercial-shawsabey-01)") in new stack
  306. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:42] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?qwait,1()") in new stack
  307. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:43] Set("Local/FMPR-999@from-internal-00004792;2", "__CWIGNORE=") in new stack
  308. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:44] Set("Local/FMPR-999@from-internal-00004792;2", "__KEEPCID=TRUE") in new stack
  309. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:45] GotoIf("Local/FMPR-999@from-internal-00004792;2", "0?usegoto,1") in new stack
  310. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:46] GotoIf("Local/FMPR-999@from-internal-00004792;2", "1?godial") in new stack
  311. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-dial-one,s,51)
  312. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:51] Macro("Local/FMPR-999@from-internal-00004792;2", "dialout-one-predial-hook,") in new stack
  313. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  314. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:52] ExecIf("Local/FMPR-999@from-internal-00004792;2", "1?Set(D_OPTIONS=trM(auto-blkvm)I)") in new stack
  315. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:53] NoOp("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  316. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:54] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(D_OPTIONS=trM(auto-blkvm)Ig)") in new stack
  317. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:55] Dial("Local/FMPR-999@from-internal-00004792;2", "SIP/999,18,trM(auto-blkvm)Ib(func-apply-sipheaders^s^1)") in new stack
  318. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] netsock2.c: Using SIP RTP TOS bits 184
  319. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] netsock2.c: Using SIP RTP CoS mark 5
  320. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_stack.c: SIP/999-0001435f Internal Gosub(func-apply-sipheaders,s,1) start
  321. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/999-0001435f", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  322. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/999-0001435f", "Applying SIP Headers to channel") in new stack
  323. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/999-0001435f", "SIPHEADERKEYS=") in new stack
  324. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("SIP/999-0001435f", "0?Set(Rheader=1)") in new stack
  325. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/999-0001435f", "0") in new stack
  326. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_while.c: Jumping to priority 9
  327. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/999-0001435f", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  328. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/999-0001435f", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
  329. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:12] Return("SIP/999-0001435f", "") in new stack
  330. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_stack.c: Spawn extension (from-internal, FMPR-999, 1) exited non-zero on 'SIP/999-0001435f'
  331. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_stack.c: SIP/999-0001435f Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  332. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_dial.c: Called SIP/999
  333. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_dial.c: Local/FMPR-999@from-internal-00004792;1 is ringing
  334. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_dial.c: Connected line update to Local/FMPR-999@from-internal-00004792;2 prevented.
  335. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_dial.c: SIP/999-0001435f is ringing
  336. [2018-08-10 23:47:02] VERBOSE[32204][C-0000b182] app_dial.c: Local/FMPR-999@from-internal-00004792;1 is ringing
  337. [2018-08-10 23:47:02] VERBOSE[32249][C-0000b182] app_dial.c: SIP/999-0001435f is ringing
  338. [2018-08-10 23:47:03] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  339. [2018-08-10 23:47:03] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  340. [2018-08-10 23:47:03] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  341. [2018-08-10 23:47:03] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  342. [2018-08-10 23:47:04] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  343. [2018-08-10 23:47:04] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  344. [2018-08-10 23:47:04] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  345. [2018-08-10 23:47:04] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  346. [2018-08-10 23:47:05] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  347. [2018-08-10 23:47:05] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  348. [2018-08-10 23:47:05] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  349. [2018-08-10 23:47:05] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  350. [2018-08-10 23:47:06] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  351. [2018-08-10 23:47:06] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  352. [2018-08-10 23:47:06] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  353. [2018-08-10 23:47:06] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  354. [2018-08-10 23:47:07] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  355. [2018-08-10 23:47:07] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  356. [2018-08-10 23:47:07] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  357. [2018-08-10 23:47:07] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  358. [2018-08-10 23:47:08] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  359. [2018-08-10 23:47:08] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  360. [2018-08-10 23:47:08] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  361. [2018-08-10 23:47:08] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  362. [2018-08-10 23:47:09] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  363. [2018-08-10 23:47:09] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  364. [2018-08-10 23:47:09] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  365. [2018-08-10 23:47:09] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  366. [2018-08-10 23:47:10] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  367. [2018-08-10 23:47:10] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  368. [2018-08-10 23:47:10] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  369. [2018-08-10 23:47:10] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  370. [2018-08-10 23:47:11] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  371. [2018-08-10 23:47:11] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  372. [2018-08-10 23:47:11] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  373. [2018-08-10 23:47:11] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  374. [2018-08-10 23:47:12] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  375. [2018-08-10 23:47:12] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  376. [2018-08-10 23:47:12] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  377. [2018-08-10 23:47:12] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  378. [2018-08-10 23:47:13] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  379. [2018-08-10 23:47:13] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  380. [2018-08-10 23:47:13] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  381. [2018-08-10 23:47:13] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  382. [2018-08-10 23:47:14] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  383. [2018-08-10 23:47:14] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  384. [2018-08-10 23:47:14] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  385. [2018-08-10 23:47:14] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  386. [2018-08-10 23:47:15] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  387. [2018-08-10 23:47:15] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  388. [2018-08-10 23:47:15] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  389. [2018-08-10 23:47:15] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  390. [2018-08-10 23:47:16] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  391. [2018-08-10 23:47:16] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  392. [2018-08-10 23:47:16] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  393. [2018-08-10 23:47:16] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  394. [2018-08-10 23:47:17] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  395. [2018-08-10 23:47:17] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  396. [2018-08-10 23:47:17] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  397. [2018-08-10 23:47:17] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  398. [2018-08-10 23:47:18] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  399. [2018-08-10 23:47:18] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  400. [2018-08-10 23:47:18] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  401. [2018-08-10 23:47:18] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  402. [2018-08-10 23:47:19] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?start") in new stack
  403. [2018-08-10 23:47:19] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (from-internal,FMGL-5555551234#,4)
  404. [2018-08-10 23:47:19] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:4] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?dodnd") in new stack
  405. [2018-08-10 23:47:19] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:5] Wait("Local/FMGL-5555551234#@from-internal-00004793;2", "1") in new stack
  406. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:6] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?start") in new stack
  407. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:7] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "SHARED(FM_DND,SIP/OneConnect-SIP-YVR1-0001435e)=") in new stack
  408. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [FMGL-5555551234#@from-internal:8] Macro("Local/FMGL-5555551234#@from-internal-00004793;2", "dial,60,tr,5555551234#") in new stack
  409. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:1] NoOp("Local/FMGL-5555551234#@from-internal-00004793;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  410. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:2] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "__CRM_SOURCE=7788190474") in new stack
  411. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:3] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(ALERT_INFO=)") in new stack
  412. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:4] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(ALERT_INFO=)") in new stack
  413. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:5] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(ALERT_INFO=)") in new stack
  414. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:6] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?Set(CHANNEL(musicclass)=commercial-shawsabey-01)") in new stack
  415. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:7] AGI("Local/FMGL-5555551234#@from-internal-00004793;2", "dialparties.agi") in new stack
  416. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  417. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] app_dial.c: Nobody picked up in 18000 ms
  418. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] app_stack.c: SIP/999-0001435f Internal Gosub(crm-hangup,s,1) start
  419. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/999-0001435f", "Sending Hangup to CRM") in new stack
  420. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/999-0001435f", "HANGUP CAUSE: 16") in new stack
  421. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/999-0001435f", "0?Set(__CRM_VOICEMAIL=)") in new stack
  422. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/999-0001435f", "MASTER CHANNEL: 1533970022.175996 = 1533970017.175991") in new stack
  423. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/999-0001435f", "1?return") in new stack
  424. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (crm-hangup,s,8)
  425. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@crm-hangup:8] Return("SIP/999-0001435f", "") in new stack
  426. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] app_stack.c: Spawn extension (from-internal, FMPR-999, 1) exited non-zero on 'SIP/999-0001435f'
  427. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] app_stack.c: SIP/999-0001435f Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  428. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:56] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?MacroExit()") in new stack
  429. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:57] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(DIALSTATUS=)") in new stack
  430. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:58] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?s-NOANSWER,1()") in new stack
  431. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-dial-one:59] MacroExit("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  432. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:7] Set("Local/FMPR-999@from-internal-00004792;2", "__CWIGNORE=") in new stack
  433. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:8] Set("Local/FMPR-999@from-internal-00004792;2", "PR_DIALSTATUS=NOANSWER") in new stack
  434. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:9] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?docfu,1()") in new stack
  435. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:10] GosubIf("Local/FMPR-999@from-internal-00004792;2", "0?docfb,1()") in new stack
  436. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:11] Set("Local/FMPR-999@from-internal-00004792;2", "DIALSTATUS=NOANSWER") in new stack
  437. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-simple-dial:12] Goto("Local/FMPR-999@from-internal-00004792;2", "s-NOANSWER,1") in new stack
  438. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-simple-dial,s-NOANSWER,1)
  439. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s-NOANSWER@macro-simple-dial:1] NoOp("Local/FMPR-999@from-internal-00004792;2", "Extension is reporting s-NOANSWER") in new stack
  440. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:6] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(SHARED(FM_DND,SIP/OneConnect-SIP-YVR1-0001435e)=DND)") in new stack
  441. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [FMPR-999@from-internal:7] Hangup("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  442. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Spawn extension (from-internal, FMPR-999, 7) exited non-zero on 'Local/FMPR-999@from-internal-00004792;2'
  443. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [h@from-internal:1] Macro("Local/FMPR-999@from-internal-00004792;2", "hangupcall") in new stack
  444. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("Local/FMPR-999@from-internal-00004792;2", "1?theend") in new stack
  445. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  446. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("Local/FMPR-999@from-internal-00004792;2", "0?Set(CDR(recordingfile)=)") in new stack
  447. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Executing [s@macro-hangupcall:4] Hangup("Local/FMPR-999@from-internal-00004792;2", "") in new stack
  448. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'Local/FMPR-999@from-internal-00004792;2' in macro 'hangupcall'
  449. [2018-08-10 23:47:20] VERBOSE[32249][C-0000b182] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMPR-999@from-internal-00004792;2'
  450. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMPR-999@from-internal-00004792;1 Internal Gosub(crm-hangup,s,1) start
  451. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:1] NoOp("Local/FMPR-999@from-internal-00004792;1", "Sending Hangup to CRM") in new stack
  452. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:2] NoOp("Local/FMPR-999@from-internal-00004792;1", "HANGUP CAUSE: 16") in new stack
  453. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:3] ExecIf("Local/FMPR-999@from-internal-00004792;1", "0?Set(__CRM_VOICEMAIL=)") in new stack
  454. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:4] NoOp("Local/FMPR-999@from-internal-00004792;1", "MASTER CHANNEL: 1533970022.175992 = 1533970017.175991") in new stack
  455. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:5] GotoIf("Local/FMPR-999@from-internal-00004792;1", "1?return") in new stack
  456. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx_builtins.c: Goto (crm-hangup,s,8)
  457. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:8] Return("Local/FMPR-999@from-internal-00004792;1", "") in new stack
  458. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] app_stack.c: Spawn extension (from-internal, 999, 1) exited non-zero on 'Local/FMPR-999@from-internal-00004792;1'
  459. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] app_stack.c: Local/FMPR-999@from-internal-00004792;1 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  460. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Starting New Dialparties.agi
  461. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Caller ID name is '7788190474' number is '7788190474'
  462. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: CW Ignore is:
  463. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: CF Ignore is:
  464. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
  465. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Methodology of ring is  'ringall'
  466. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Added extension 5555551234# to extension map
  467. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Extension 5555551234# cf is disabled
  468. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: dialparties.agi: Filtered ARG3: 5555551234
  469. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] res_agi.c: <Local/FMGL-5555551234#@from-internal-00004793;2>AGI Script dialparties.agi completed, returning 0
  470. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:10] NoOp("Local/FMGL-5555551234#@from-internal-00004793;2", "Returned from dialparties with groups to dial") in new stack
  471. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:11] NoOp("Local/FMGL-5555551234#@from-internal-00004793;2", "ringall array 5555551234# ") in new stack
  472. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:12] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "__FMGL_DIAL=5555551234#") in new stack
  473. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:13] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "LOOPCNT=1") in new stack
  474. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:14] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "ITER=1") in new stack
  475. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:15] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "__EXTTOCALL=5555551234") in new stack
  476. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:16] NoOp("Local/FMGL-5555551234#@from-internal-00004793;2", "Working with 5555551234") in new stack
  477. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:17] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  478. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:18] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  479. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:19] Set("Local/FMGL-5555551234#@from-internal-00004793;2", "ITER=2") in new stack
  480. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:20] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?ndloopbegin") in new stack
  481. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:21] Macro("Local/FMGL-5555551234#@from-internal-00004793;2", "dial-ringall-predial-hook,") in new stack
  482. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("Local/FMGL-5555551234#@from-internal-00004793;2", "") in new stack
  483. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:22] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(ds=Local/5555551234@from-internal/n,60,trM(auto-blkvm)g)") in new stack
  484. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-dial:23] Dial("Local/FMGL-5555551234#@from-internal-00004793;2", "Local/5555551234@from-internal/n,60,trM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
  485. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] app_stack.c: Local/5555551234@from-internal-00004794;1 Internal Gosub(func-apply-sipheaders,s,1) start
  486. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("Local/5555551234@from-internal-00004794;1", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  487. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("Local/5555551234@from-internal-00004794;1", "Applying SIP Headers to channel") in new stack
  488. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:3] Set("Local/5555551234@from-internal-00004794;1", "SIPHEADERKEYS=") in new stack
  489. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:4] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(Rheader=1)") in new stack
  490. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:5] While("Local/5555551234@from-internal-00004794;1", "0") in new stack
  491. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] app_while.c: Jumping to priority 9
  492. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("Local/5555551234@from-internal-00004794;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack
  493. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
  494. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@func-apply-sipheaders:12] Return("Local/5555551234@from-internal-00004794;1", "") in new stack
  495. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] app_stack.c: Spawn extension (from-internal, FMGL-5555551234#, 1) exited non-zero on 'Local/5555551234@from-internal-00004794;1'
  496. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] app_stack.c: Local/5555551234@from-internal-00004794;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  497. [2018-08-10 23:47:20] VERBOSE[32250][C-0000b182] app_dial.c: Called Local/5555551234@from-internal/n
  498. [2018-08-10 23:47:20] VERBOSE[32204][C-0000b182] app_dial.c: Local/FMGL-5555551234#@from-internal-00004793;1 is ringing
  499. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@from-internal:1] Macro("Local/5555551234@from-internal-00004794;2", "user-callerid,LIMIT") in new stack
  500. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:1] Set("Local/5555551234@from-internal-00004794;2", "TOUCH_MONITOR=1533970040.175998") in new stack
  501. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:2] Set("Local/5555551234@from-internal-00004794;2", "AMPUSER=7788190474") in new stack
  502. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("Local/5555551234@from-internal-00004794;2", "0?report") in new stack
  503. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(REALCALLERIDNUM=7788190474)") in new stack
  504. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:5] Set("Local/5555551234@from-internal-00004794;2", "AMPUSER=") in new stack
  505. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("Local/5555551234@from-internal-00004794;2", "0?limit") in new stack
  506. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:7] Set("Local/5555551234@from-internal-00004794;2", "AMPUSERCIDNAME=") in new stack
  507. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  508. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("Local/5555551234@from-internal-00004794;2", "1?report") in new stack
  509. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,16)
  510. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:16] NoOp("Local/5555551234@from-internal-00004794;2", "Macro Depth is 1") in new stack
  511. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("Local/5555551234@from-internal-00004794;2", "1?report2:macroerror") in new stack
  512. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,18)
  513. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("Local/5555551234@from-internal-00004794;2", "1?continue") in new stack
  514. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-user-callerid,s,37)
  515. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:37] Set("Local/5555551234@from-internal-00004794;2", "CALLERID(number)=7788190474") in new stack
  516. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:38] Set("Local/5555551234@from-internal-00004794;2", "CALLERID(name)=7788190474") in new stack
  517. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("Local/5555551234@from-internal-00004794;2", "0?cnum") in new stack
  518. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:40] Set("Local/5555551234@from-internal-00004794;2", "CDR(cnam)=7788190474") in new stack
  519. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:41] Set("Local/5555551234@from-internal-00004794;2", "CDR(cnum)=7788190474") in new stack
  520. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-user-callerid:42] Set("Local/5555551234@from-internal-00004794;2", "CHANNEL(language)=en") in new stack
  521. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@from-internal:2] Set("Local/5555551234@from-internal-00004794;2", "ROUTEUSER=5555551234") in new stack
  522. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@from-internal:3] Set("Local/5555551234@from-internal-00004794;2", "ROUTEUSER=999") in new stack
  523. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@from-internal:4] GotoIf("Local/5555551234@from-internal-00004794;2", "1?notblind") in new stack
  524. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (from-internal,5555551234,7)
  525. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@from-internal:7] GotoIf("Local/5555551234@from-internal-00004794;2", "1?restrictedroute-601bcbd12379a3a03bcbad773954109d,5555551234,2:outbound-allroutes,5555551234,2") in new stack
  526. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (restrictedroute-601bcbd12379a3a03bcbad773954109d,5555551234,2)
  527. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:2] Gosub("Local/5555551234@from-internal-00004794;2", "sub-record-check,s,1(out,5555551234,dontcare)") in new stack
  528. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:1] GotoIf("Local/5555551234@from-internal-00004794;2", "0?initialized") in new stack
  529. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:2] Set("Local/5555551234@from-internal-00004794;2", "__REC_STATUS=INITIALIZED") in new stack
  530. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:3] Set("Local/5555551234@from-internal-00004794;2", "NOW=1533970040") in new stack
  531. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:4] Set("Local/5555551234@from-internal-00004794;2", "__DAY=10") in new stack
  532. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:5] Set("Local/5555551234@from-internal-00004794;2", "__MONTH=08") in new stack
  533. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:6] Set("Local/5555551234@from-internal-00004794;2", "__YEAR=2018") in new stack
  534. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:7] Set("Local/5555551234@from-internal-00004794;2", "__TIMESTR=20180810-234720") in new stack
  535. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:8] Set("Local/5555551234@from-internal-00004794;2", "__FROMEXTEN=7788190474") in new stack
  536. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:9] Set("Local/5555551234@from-internal-00004794;2", "__MON_FMT=wav") in new stack
  537. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:10] NoOp("Local/5555551234@from-internal-00004794;2", "Recordings initialized") in new stack
  538. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:11] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(ARG3=dontcare)") in new stack
  539. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:12] Set("Local/5555551234@from-internal-00004794;2", "REC_POLICY_MODE_SAVE=") in new stack
  540. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:13] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(REC_STATUS=NO)") in new stack
  541. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:14] GotoIf("Local/5555551234@from-internal-00004794;2", "3?checkaction") in new stack
  542. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (sub-record-check,s,17)
  543. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@sub-record-check:17] GotoIf("Local/5555551234@from-internal-00004794;2", "1?sub-record-check,out,1") in new stack
  544. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (sub-record-check,out,1)
  545. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [out@sub-record-check:1] NoOp("Local/5555551234@from-internal-00004794;2", "Outbound Recording Check from 7788190474 to 5555551234") in new stack
  546. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [out@sub-record-check:2] Set("Local/5555551234@from-internal-00004794;2", "RECMODE=") in new stack
  547. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [out@sub-record-check:3] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Goto(routewins)") in new stack
  548. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (sub-record-check,out,7)
  549. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [out@sub-record-check:7] Gosub("Local/5555551234@from-internal-00004794;2", "recordcheck,1(dontcare,out,5555551234)") in new stack
  550. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("Local/5555551234@from-internal-00004794;2", "Starting recording check against dontcare") in new stack
  551. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("Local/5555551234@from-internal-00004794;2", "dontcare") in new stack
  552. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  553. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [recordcheck@sub-record-check:3] Return("Local/5555551234@from-internal-00004794;2", "") in new stack
  554. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [out@sub-record-check:8] Return("Local/5555551234@from-internal-00004794;2", "") in new stack
  555. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:3] ExecIf("Local/5555551234@from-internal-00004794;2", "0 ?Set(CDR(accountcode)=)") in new stack
  556. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:4] Set("Local/5555551234@from-internal-00004794;2", "MOHCLASS=commercial-shawsabey-01") in new stack
  557. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:5] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(TRUNKCIDOVERRIDE=<6046892441>)") in new stack
  558. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:6] Set("Local/5555551234@from-internal-00004794;2", "_NODEST=") in new stack
  559. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [5555551234@restrictedroute-601bcbd12379a3a03bcbad773954109d:7] Macro("Local/5555551234@from-internal-00004794;2", "dialout-trunk,3,5555551234,,off") in new stack
  560. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:1] Set("Local/5555551234@from-internal-00004794;2", "DIAL_TRUNK=3") in new stack
  561. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(DIAL_OPTIONS=tr)") in new stack
  562. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("Local/5555551234@from-internal-00004794;2", "0?sub-pincheck,s,1()") in new stack
  563. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:4] GotoIf("Local/5555551234@from-internal-00004794;2", "0?disabletrunk,1") in new stack
  564. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:5] Set("Local/5555551234@from-internal-00004794;2", "DIAL_NUMBER=5555551234") in new stack
  565. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:6] Set("Local/5555551234@from-internal-00004794;2", "DIAL_TRUNK_OPTIONS=tr") in new stack
  566. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:7] Set("Local/5555551234@from-internal-00004794;2", "OUTBOUND_GROUP=OUT_3") in new stack
  567. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:8] Set("Local/5555551234@from-internal-00004794;2", "DIAL_TRUNK_OPTIONS=") in new stack
  568. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf("Local/5555551234@from-internal-00004794;2", "1?nomax") in new stack
  569. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-dialout-trunk,s,11)
  570. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf("Local/5555551234@from-internal-00004794;2", "0?skipoutcid") in new stack
  571. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:12] Macro("Local/5555551234@from-internal-00004794;2", "outbound-callerid,3") in new stack
  572. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(CALLERPRES(name-pres)=allowed_not_screened)") in new stack
  573. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(CALLERPRES(num-pres)=allowed_not_screened)") in new stack
  574. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(REALCALLERIDNUM=7788190474)") in new stack
  575. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(AMPUSER=7788190474)") in new stack
  576. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:5] GotoIf("Local/5555551234@from-internal-00004794;2", "0?normcid") in new stack
  577. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:6] Set("Local/5555551234@from-internal-00004794;2", "USEROUTCID=7788190474") in new stack
  578. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:7] GotoIf("Local/5555551234@from-internal-00004794;2", "0?normcid") in new stack
  579. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:8] GotoIf("Local/5555551234@from-internal-00004794;2", "1?bypass") in new stack
  580. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-outbound-callerid,s,10)
  581. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:10] Set("Local/5555551234@from-internal-00004794;2", "EMERGENCYCID=") in new stack
  582. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:11] Set("Local/5555551234@from-internal-00004794;2", "TRUNKOUTCID=") in new stack
  583. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:12] GotoIf("Local/5555551234@from-internal-00004794;2", "1?trunkcid") in new stack
  584. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-outbound-callerid,s,17)
  585. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:17] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CALLERID(all)=)") in new stack
  586. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(CALLERID(all)=7788190474)") in new stack
  587. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CALLERID(all)=)") in new stack
  588. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
  589. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
  590. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:22] Set("Local/5555551234@from-internal-00004794;2", "CDR(outbound_cnum)=7788190474") in new stack
  591. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-outbound-callerid:23] Set("Local/5555551234@from-internal-00004794;2", "CDR(outbound_cnam)=") in new stack
  592. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:13] GosubIf("Local/5555551234@from-internal-00004794;2", "0?sub-flp-3,s,1()") in new stack
  593. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:14] Set("Local/5555551234@from-internal-00004794;2", "OUTNUM=5555551234") in new stack
  594. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:15] Set("Local/5555551234@from-internal-00004794;2", "custom=SIP/OneConnect-SIP-YVR1") in new stack
  595. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf("Local/5555551234@from-internal-00004794;2", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^commercial-shawsabey-01))") in new stack
  596. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^commercial-shawsabey-01)M(confirm))") in new stack
  597. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:18] Macro("Local/5555551234@from-internal-00004794;2", "dialout-trunk-predial-hook,") in new stack
  598. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/5555551234@from-internal-00004794;2", "") in new stack
  599. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf("Local/5555551234@from-internal-00004794;2", "1?skipcrm") in new stack
  600. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx_builtins.c: Goto (macro-dialout-trunk,s,25)
  601. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:25] NoOp("Local/5555551234@from-internal-00004794;2", "CRM Finished") in new stack
  602. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:26] GotoIf("Local/5555551234@from-internal-00004794;2", "0?bypass,1") in new stack
  603. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:27] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CONNECTEDLINE(num,i)=5555551234)") in new stack
  604. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CONNECTEDLINE(name,i)=CID:7788190474)") in new stack
  605. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("Local/5555551234@from-internal-00004794;2", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)7788190474)") in new stack
  606. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:30] GotoIf("Local/5555551234@from-internal-00004794;2", "0?customtrunk") in new stack
  607. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-dialout-trunk:31] Dial("Local/5555551234@from-internal-00004794;2", "SIP/OneConnect-SIP-YVR1/5555551234,300,M(setmusic^commercial-shawsabey-01)") in new stack
  608. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] netsock2.c: Using SIP RTP TOS bits 184
  609. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] netsock2.c: Using SIP RTP CoS mark 5
  610. [2018-08-10 23:47:20] VERBOSE[32277][C-0000b182] app_dial.c: Called SIP/OneConnect-SIP-YVR1/5555551234
  611. [2018-08-10 23:47:30] VERBOSE[32277][C-0000b182] app_dial.c: SIP/OneConnect-SIP-YVR1-00014360 is making progress passing it to Local/5555551234@from-internal-00004794;2
  612. [2018-08-10 23:47:30] VERBOSE[32250][C-0000b182] app_dial.c: Local/5555551234@from-internal-00004794;1 is making progress passing it to Local/FMGL-5555551234#@from-internal-00004793;2
  613. [2018-08-10 23:47:51] VERBOSE[32277][C-0000b182] app_dial.c: SIP/OneConnect-SIP-YVR1-00014360 answered Local/5555551234@from-internal-00004794;2
  614. [2018-08-10 23:47:51] VERBOSE[32277][C-0000b182] pbx.c: Executing [s@macro-setmusic:1] Set("SIP/OneConnect-SIP-YVR1-00014360", "CHANNEL(musicclass)=commercial-shawsabey-01") in new stack
  615. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] app_dial.c: Local/5555551234@from-internal-00004794;1 answered Local/FMGL-5555551234#@from-internal-00004793;2
  616. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:1] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(CDR(recordingfile)=.wav)") in new stack
  617. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:2] Set("Local/5555551234@from-internal-00004794;1", "__MACRO_RESULT=") in new stack
  618. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:3] Set("Local/5555551234@from-internal-00004794;1", "CFIGNORE=") in new stack
  619. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:4] Set("Local/5555551234@from-internal-00004794;1", "MASTER_CHANNEL(CFIGNORE)=") in new stack
  620. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:5] Set("Local/5555551234@from-internal-00004794;1", "FORWARD_CONTEXT=from-internal") in new stack
  621. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:6] Set("Local/5555551234@from-internal-00004794;1", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
  622. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:7] Macro("Local/5555551234@from-internal-00004794;1", "blkvm-clr,") in new stack
  623. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:1] Set("Local/5555551234@from-internal-00004794;1", "SHARED(BLKVM,SIP/OneConnect-SIP-YVR1-0001435e)=") in new stack
  624. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:2] Set("Local/5555551234@from-internal-00004794;1", "GOSUB_RETVAL=") in new stack
  625. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("Local/5555551234@from-internal-00004794;1", "") in new stack
  626. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=5555551234@from-internal/n)") in new stack
  627. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:9] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
  628. [2018-08-10 23:47:51] VERBOSE[32342][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-00014360 joined 'simple_bridge' basic-bridge <584c2a20-4a7c-4129-a2f7-12cd67f472b9>
  629. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] app_dial.c: Local/FMGL-5555551234#@from-internal-00004793;1 answered SIP/OneConnect-SIP-YVR1-0001435e
  630. [2018-08-10 23:47:51] VERBOSE[32277][C-0000b182] bridge_channel.c: Channel Local/5555551234@from-internal-00004794;2 joined 'simple_bridge' basic-bridge <584c2a20-4a7c-4129-a2f7-12cd67f472b9>
  631. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:1] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(CDR(recordingfile)=.wav)") in new stack
  632. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:2] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "__MACRO_RESULT=") in new stack
  633. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:3] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "CFIGNORE=") in new stack
  634. [2018-08-10 23:47:51] VERBOSE[32343][C-0000b182] bridge_channel.c: Channel Local/5555551234@from-internal-00004794;1 joined 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  635. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:4] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "MASTER_CHANNEL(CFIGNORE)=") in new stack
  636. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:5] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "FORWARD_CONTEXT=from-internal") in new stack
  637. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:6] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
  638. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:7] Macro("Local/FMGL-5555551234#@from-internal-00004793;1", "blkvm-clr,") in new stack
  639. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:1] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "SHARED(BLKVM,SIP/OneConnect-SIP-YVR1-0001435e)=") in new stack
  640. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] bridge_channel.c: Channel Local/FMGL-5555551234#@from-internal-00004793;2 joined 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  641. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:2] Set("Local/FMGL-5555551234#@from-internal-00004793;1", "GOSUB_RETVAL=") in new stack
  642. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("Local/FMGL-5555551234#@from-internal-00004793;1", "") in new stack
  643. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=FMGL-5555551234#@from-internal)") in new stack
  644. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@macro-auto-blkvm:9] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
  645. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] bridge_channel.c: Channel Local/FMGL-5555551234#@from-internal-00004793;1 joined 'simple_bridge' basic-bridge <73ed27f3-eafa-4014-a396-e63f6c1ce883>
  646. [2018-08-10 23:47:51] VERBOSE[32204][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-0001435e joined 'simple_bridge' basic-bridge <73ed27f3-eafa-4014-a396-e63f6c1ce883>
  647. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-0001435e left 'simple_bridge' basic-bridge <73ed27f3-eafa-4014-a396-e63f6c1ce883>
  648. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] bridge_channel.c: Channel Local/FMGL-5555551234#@from-internal-00004793;2 left 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  649. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-0001435e swapped with Local/FMGL-5555551234#@from-internal-00004793;2 into 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  650. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] app_macro.c: Spawn extension (macro-dial, s, 23) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;2' in macro 'dial'
  651. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Spawn extension (from-internal, FMGL-5555551234#, 8) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;2'
  652. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [h@from-internal:1] Macro("Local/FMGL-5555551234#@from-internal-00004793;2", "hangupcall") in new stack
  653. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;2", "1?theend") in new stack
  654. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  655. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;2", "0?Set(CDR(recordingfile)=)") in new stack
  656. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Executing [s@macro-hangupcall:4] Hangup("Local/FMGL-5555551234#@from-internal-00004793;2", "") in new stack
  657. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;2' in macro 'hangupcall'
  658. [2018-08-10 23:47:51] VERBOSE[32250][C-0000b182] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;2'
  659. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] bridge_channel.c: Channel Local/FMGL-5555551234#@from-internal-00004793;1 left 'simple_bridge' basic-bridge <73ed27f3-eafa-4014-a396-e63f6c1ce883>
  660. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] app_stack.c: Local/FMGL-5555551234#@from-internal-00004793;1 Internal Gosub(crm-hangup,s,1) start
  661. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:1] NoOp("Local/FMGL-5555551234#@from-internal-00004793;1", "Sending Hangup to CRM") in new stack
  662. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:2] NoOp("Local/FMGL-5555551234#@from-internal-00004793;1", "HANGUP CAUSE: 16") in new stack
  663. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:3] ExecIf("Local/FMGL-5555551234#@from-internal-00004793;1", "0?Set(__CRM_VOICEMAIL=)") in new stack
  664. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:4] NoOp("Local/FMGL-5555551234#@from-internal-00004793;1", "MASTER CHANNEL: 1533970022.175994 = 1533970017.175991") in new stack
  665. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:5] GotoIf("Local/FMGL-5555551234#@from-internal-00004793;1", "1?return") in new stack
  666. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx_builtins.c: Goto (crm-hangup,s,8)
  667. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] pbx.c: Executing [s@crm-hangup:8] Return("Local/FMGL-5555551234#@from-internal-00004793;1", "") in new stack
  668. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] app_stack.c: Spawn extension (macro-dial, s, 1) exited non-zero on 'Local/FMGL-5555551234#@from-internal-00004793;1'
  669. [2018-08-10 23:47:51] VERBOSE[32344][C-0000b182] app_stack.c: Local/FMGL-5555551234#@from-internal-00004793;1 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  670. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-0001435e left 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  671. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] bridge_channel.c: Channel Local/5555551234@from-internal-00004794;1 left 'simple_bridge' basic-bridge <90b8c0c9-ef91-4637-b80f-c7a892f9a650>
  672. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] app_macro.c: Spawn extension (macro-dial, s, 23) exited non-zero on 'SIP/OneConnect-SIP-YVR1-0001435e' in macro 'dial'
  673. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] app_stack.c: Local/5555551234@from-internal-00004794;1 Internal Gosub(crm-hangup,s,1) start
  674. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:1] NoOp("Local/5555551234@from-internal-00004794;1", "Sending Hangup to CRM") in new stack
  675. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Spawn extension (followme-sub, 999, 39) exited non-zero on 'SIP/OneConnect-SIP-YVR1-0001435e'
  676. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:2] NoOp("Local/5555551234@from-internal-00004794;1", "HANGUP CAUSE: 16") in new stack
  677. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] app_stack.c: SIP/OneConnect-SIP-YVR1-0001435e Internal Gosub(crm-hangup,s,1) start
  678. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "Sending Hangup to CRM") in new stack
  679. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:3] ExecIf("Local/5555551234@from-internal-00004794;1", "0?Set(__CRM_VOICEMAIL=)") in new stack
  680. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:4] NoOp("Local/5555551234@from-internal-00004794;1", "MASTER CHANNEL: 1533970040.175997 = 1533970017.175991") in new stack
  681. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "HANGUP CAUSE: 16") in new stack
  682. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?Set(__CRM_VOICEMAIL=)") in new stack
  683. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/OneConnect-SIP-YVR1-0001435e", "MASTER CHANNEL: 1533970017.175991 = 1533970017.175991") in new stack
  684. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:5] GotoIf("Local/5555551234@from-internal-00004794;1", "1?return") in new stack
  685. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx_builtins.c: Goto (crm-hangup,s,8)
  686. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] pbx.c: Executing [s@crm-hangup:8] Return("Local/5555551234@from-internal-00004794;1", "") in new stack
  687. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/OneConnect-SIP-YVR1-0001435e", "0?return") in new stack
  688. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:6] Set("SIP/OneConnect-SIP-YVR1-0001435e", "__CRM_HANGUP=1") in new stack
  689. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] app_stack.c: Spawn extension (macro-dial, s, 1) exited non-zero on 'Local/5555551234@from-internal-00004794;1'
  690. [2018-08-10 23:47:56] VERBOSE[32343][C-0000b182] app_stack.c: Local/5555551234@from-internal-00004794;1 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  691. [2018-08-10 23:47:56] VERBOSE[32277][C-0000b182] bridge_channel.c: Channel Local/5555551234@from-internal-00004794;2 left 'simple_bridge' basic-bridge <584c2a20-4a7c-4129-a2f7-12cd67f472b9>
  692. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/OneConnect-SIP-YVR1-0001435e", "sangomacrm.agi") in new stack
  693. [2018-08-10 23:47:56] VERBOSE[32204][C-0000b182] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
  694. [2018-08-10 23:47:56] VERBOSE[32342][C-0000b182] bridge_channel.c: Channel SIP/OneConnect-SIP-YVR1-00014360 left 'simple_bridge' basic-bridge <584c2a20-4a7c-4129-a2f7-12cd67f472b9>
  695. [2018-08-10 23:47:56] VERBOSE[32277][C-0000b182] app_macro.c: Spawn extension (macro-dialout-trunk, s, 31) exited non-zero on 'Local/5555551234@from-internal-00004794;2' in macro 'dialout-trunk'
  696. [2018-08-10 23:47:56] VERBOSE[32277][C-0000b182] pbx.c: Spawn extension (restrictedroute-601bcbd12379a3a03bcbad773954109d, 5555551234, 7) exited non-zero on 'Local/5555551234@from-internal-00004794;2'
  697. [2018-08-10 23:47:56] VERBOSE[32277][C-0000b182] pbx.c: Executing [h@restrictedroute-601bcbd12379a3a03bcbad773954109d:1] Hangup("Local/5555551234@from-internal-00004794;2", "") in new stack
  698. [2018-08-10 23:47:56] VERBOSE[32277][C-0000b182] pbx.c: Spawn extension (restrictedroute-601bcbd12379a3a03bcbad773954109d, h, 1) exited non-zero on 'Local/5555551234@from-internal-00004794;2'
  699. [2018-08-10 23:47:57] VERBOSE[32204][C-0000b182] res_agi.c: <SIP/OneConnect-SIP-YVR1-0001435e>AGI Script sangomacrm.agi completed, returning 0
  700. [2018-08-10 23:47:57] VERBOSE[32204][C-0000b182] pbx.c: Executing [s@crm-hangup:8] Return("SIP/OneConnect-SIP-YVR1-0001435e", "") in new stack
  701. [2018-08-10 23:47:57] VERBOSE[32204][C-0000b182] app_stack.c: Spawn extension (followme-sub, 999, 39) exited non-zero on 'SIP/OneConnect-SIP-YVR1-0001435e'
  702. [2018-08-10 23:47:57] VERBOSE[32204][C-0000b182] app_stack.c: SIP/OneConnect-SIP-YVR1-0001435e Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

Reply to "Re: FollowMe: Working extension"

Here you can reply to the paste above