Failed incoming call after 30 seconds

From Lewis Irving, 7 Months ago, written in Plain Text, viewed 3 times.
URL https://pastebin.freepbx.org/view/8cdf766b Embed
Download Paste or View Raw
  1. [2020-11-25 20:56:01] VERBOSE[2457] pbx_variables.c: Setting global variable 'SIPDOMAIN' to '203.54.133.114'
  2. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn-toheader:1] NoOp("PJSIP/Faktortel-00000004", "Attempting to extract DID from SIP To header") in new stack
  3. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn-toheader:2] GotoIf("PJSIP/Faktortel-00000004", "0?SIP") in new stack
  4. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn-toheader:3] GotoIf("PJSIP/Faktortel-00000004", "1?PJSIP") in new stack
  5. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (from-pstn-toheader,0256247018,7)
  6. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn-toheader:7] Goto("PJSIP/Faktortel-00000004", "from-pstn,0256247018,1") in new stack
  7. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (from-pstn,0256247018,1)
  8. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:1] Set("PJSIP/Faktortel-00000004", "__DIRECTION=INBOUND") in new stack
  9. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:2] Gosub("PJSIP/Faktortel-00000004", "sub-record-check,s,1(in,0256247018,dontcare)") in new stack
  10. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Faktortel-00000004", "0?initialized") in new stack
  11. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/Faktortel-00000004", "__REC_STATUS=INITIALIZED") in new stack
  12. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/Faktortel-00000004", "NOW=1606298161") in new stack
  13. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/Faktortel-00000004", "__DAY=25") in new stack
  14. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/Faktortel-00000004", "__MONTH=11") in new stack
  15. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/Faktortel-00000004", "__YEAR=2020") in new stack
  16. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/Faktortel-00000004", "__TIMESTR=20201125-205601") in new stack
  17. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/Faktortel-00000004", "__FROMEXTEN=unknown") in new stack
  18. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/Faktortel-00000004", "__MON_FMT=wav") in new stack
  19. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Faktortel-00000004", "Recordings initialized") in new stack
  20. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ARG3=dontcare)") in new stack
  21. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Faktortel-00000004", "REC_POLICY_MODE_SAVE=") in new stack
  22. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Faktortel-00000004", "0?Set(REC_STATUS=NO)") in new stack
  23. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Faktortel-00000004", "2?checkaction") in new stack
  24. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,s,17)
  25. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Faktortel-00000004", "1?sub-record-check,in,1") in new stack
  26. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,in,1)
  27. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/Faktortel-00000004", "Inbound Recording Check to 0256247018") in new stack
  28. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/Faktortel-00000004", "FROMEXTEN=unknown") in new stack
  29. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/Faktortel-00000004", "10?Set(FROMEXTEN=0266913905)") in new stack
  30. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/Faktortel-00000004", "recordcheck,1(dontcare,in,0256247018)") in new stack
  31. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Faktortel-00000004", "Starting recording check against dontcare") in new stack
  32. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Faktortel-00000004", "dontcare") in new stack
  33. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  34. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Faktortel-00000004", "") in new stack
  35. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/Faktortel-00000004", "") in new stack
  36. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:3] Set("PJSIP/Faktortel-00000004", "CHANNEL(tonezone)=au") in new stack
  37. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:4] Set("PJSIP/Faktortel-00000004", "__FROM_DID=0256247018") in new stack
  38. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:5] Set("PJSIP/Faktortel-00000004", "returnhere=1") in new stack
  39. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:6] Gosub("PJSIP/Faktortel-00000004", "app-blacklist-check,s,1()") in new stack
  40. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/Faktortel-00000004", "0?blacklisted") in new stack
  41. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/Faktortel-00000004", "CALLED_BLACKLIST=1") in new stack
  42. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/Faktortel-00000004", "") in new stack
  43. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:7] Set("PJSIP/Faktortel-00000004", "CDR(did)=0256247018") in new stack
  44. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:8] GotoIf("PJSIP/Faktortel-00000004", "0?") in new stack
  45. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:9] ExecIf("PJSIP/Faktortel-00000004", "0 ?Set(CALLERID(name)=0266913905)") in new stack
  46. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:10] Set("PJSIP/Faktortel-00000004", "__MOHCLASS=") in new stack
  47. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:11] Set("PJSIP/Faktortel-00000004", "__REVERSAL_REJECT=FALSE") in new stack
  48. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:12] GotoIf("PJSIP/Faktortel-00000004", "1?post-reverse-charge") in new stack
  49. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (from-pstn,0256247018,14)
  50. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:14] NoOp("PJSIP/Faktortel-00000004", "") in new stack
  51. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:15] Set("PJSIP/Faktortel-00000004", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
  52. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:16] Set("PJSIP/Faktortel-00000004", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
  53. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:17] Set("PJSIP/Faktortel-00000004", "CALLERID(name-pres)=allowed_not_screened") in new stack
  54. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:18] Set("PJSIP/Faktortel-00000004", "CALLERID(num-pres)=allowed_not_screened") in new stack
  55. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:19] NoOp("PJSIP/Faktortel-00000004", "CallerID Entry Point") in new stack
  56. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:20] Set("PJSIP/Faktortel-00000004", "__CRM_DIRECTION=INBOUND") in new stack
  57. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:21] Set("PJSIP/Faktortel-00000004", "__CRM_SOURCE=0266913905") in new stack
  58. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:22] Set("PJSIP/Faktortel-00000004", "__CRM_LINKEDID=1606298161.4") in new stack
  59. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:23] AGI("PJSIP/Faktortel-00000004", "agi://127.0.0.1/sangomacrm.agi,true") in new stack
  60. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] res_agi.c: <PJSIP/Faktortel-00000004>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  61. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:24] ExecIf("PJSIP/Faktortel-00000004", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  62. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [0256247018@from-pstn:25] Goto("PJSIP/Faktortel-00000004", "timeconditions,1,1") in new stack
  63. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (timeconditions,1,1)
  64. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:1] Set("PJSIP/Faktortel-00000004", "DB(TC/1/INUSESTATE)=INUSE") in new stack
  65. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:2] Set("PJSIP/Faktortel-00000004", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
  66. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:3] NoOp("PJSIP/Faktortel-00000004", "TIMENOW: 20:56,Wed,25,Nov,Australia/Sydney") in new stack
  67. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:4] NoOp("PJSIP/Faktortel-00000004", "TIMEMATCHED: TRUE") in new stack
  68. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:5] GotoIfTime("PJSIP/Faktortel-00000004", "08:30-21:00,mon-fri,*,*,Australia/Sydney?truestate") in new stack
  69. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (timeconditions,1,17)
  70. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:17] GotoIf("PJSIP/Faktortel-00000004", "0?falsegoto") in new stack
  71. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(DB(TC/1)=)") in new stack
  72. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:19] Set("PJSIP/Faktortel-00000004", "DEVICE_STATE(Custom:TC1)=NOT_INUSE") in new stack
  73. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:20] ExecIf("PJSIP/Faktortel-00000004", "1?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
  74. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [1@timeconditions:21] GotoIf("PJSIP/Faktortel-00000004", "1?ext-group,3000,1") in new stack
  75. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (ext-group,3000,1)
  76. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:1] GotoIf("PJSIP/Faktortel-00000004", "0?cid") in new stack
  77. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:2] PlayTones("PJSIP/Faktortel-00000004", "ring") in new stack
  78. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:3] Progress("PJSIP/Faktortel-00000004", "") in new stack
  79. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:4] Macro("PJSIP/Faktortel-00000004", "user-callerid,") in new stack
  80. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/Faktortel-00000004", "TOUCH_MONITOR=1606298161.4") in new stack
  81. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/Faktortel-00000004", "AMPUSER=0266913905") in new stack
  82. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/Faktortel-00000004", "HOTDESCKCHAN=Faktortel-00000004") in new stack
  83. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/Faktortel-00000004", "HOTDESKEXTEN=Faktortel") in new stack
  84. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/Faktortel-00000004", "HOTDESKCALL=0") in new stack
  85. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HOTDESKCALL=1)") in new stack
  86. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("PJSIP/Faktortel-00000004", "0?Set(CALLERID(name)=)") in new stack
  87. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/Faktortel-00000004", "0?report") in new stack
  88. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("PJSIP/Faktortel-00000004", "1?Set(REALCALLERIDNUM=0266913905)") in new stack
  89. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/Faktortel-00000004", "AMPUSER=") in new stack
  90. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("PJSIP/Faktortel-00000004", "0?limit") in new stack
  91. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/Faktortel-00000004", "AMPUSERCIDNAME=") in new stack
  92. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/Faktortel-00000004", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
  93. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/Faktortel-00000004", "1?report") in new stack
  94. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,23)
  95. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:23] NoOp("PJSIP/Faktortel-00000004", "Macro Depth is 1") in new stack
  96. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("PJSIP/Faktortel-00000004", "1?report2:macroerror") in new stack
  97. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,25)
  98. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("PJSIP/Faktortel-00000004", "0?continue") in new stack
  99. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("PJSIP/Faktortel-00000004", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
  100. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:27] Set("PJSIP/Faktortel-00000004", "__TTL=64") in new stack
  101. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:28] GotoIf("PJSIP/Faktortel-00000004", "1?continue") in new stack
  102. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,44)
  103. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:44] Set("PJSIP/Faktortel-00000004", "CALLERID(number)=0266913905") in new stack
  104. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:45] Set("PJSIP/Faktortel-00000004", "CALLERID(name)=0266913905") in new stack
  105. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:46] GotoIf("PJSIP/Faktortel-00000004", "0?cnum") in new stack
  106. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:47] Set("PJSIP/Faktortel-00000004", "CDR(cnam)=0266913905") in new stack
  107. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:48] Set("PJSIP/Faktortel-00000004", "CDR(cnum)=0266913905") in new stack
  108. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/Faktortel-00000004", "CHANNEL(language)=en") in new stack
  109. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:5] Macro("PJSIP/Faktortel-00000004", "blkvm-setifempty,") in new stack
  110. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("PJSIP/Faktortel-00000004", "1?init") in new stack
  111. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
  112. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("PJSIP/Faktortel-00000004", "__BLKVM_CHANNEL=PJSIP/Faktortel-00000004") in new stack
  113. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("PJSIP/Faktortel-00000004", "SHARED(BLKVM,PJSIP/Faktortel-00000004)=TRUE") in new stack
  114. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("PJSIP/Faktortel-00000004", "GOSUB_RETVAL=TRUE") in new stack
  115. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("PJSIP/Faktortel-00000004", "") in new stack
  116. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:6] GotoIf("PJSIP/Faktortel-00000004", "1?skipov") in new stack
  117. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (ext-group,3000,9)
  118. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:9] Set("PJSIP/Faktortel-00000004", "RRNODEST=") in new stack
  119. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:10] Set("PJSIP/Faktortel-00000004", "__NODEST=3000") in new stack
  120. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:11] GosubIf("PJSIP/Faktortel-00000004", "0?sub-rgsetcid,s,1()") in new stack
  121. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:12] Gosub("PJSIP/Faktortel-00000004", "sub-record-check,s,1(rg,3000,dontcare)") in new stack
  122. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Faktortel-00000004", "10?initialized") in new stack
  123. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,s,10)
  124. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Faktortel-00000004", "Recordings initialized") in new stack
  125. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ARG3=dontcare)") in new stack
  126. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Faktortel-00000004", "REC_POLICY_MODE_SAVE=") in new stack
  127. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Faktortel-00000004", "0?Set(REC_STATUS=NO)") in new stack
  128. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Faktortel-00000004", "2?checkaction") in new stack
  129. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,s,17)
  130. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Faktortel-00000004", "0?sub-record-check,rg,1") in new stack
  131. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:18] NoOp("PJSIP/Faktortel-00000004", "Generic rg Recording Check - 0266913905 3000") in new stack
  132. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:19] Gosub("PJSIP/Faktortel-00000004", "recordcheck,1(dontcare,rg,3000)") in new stack
  133. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Faktortel-00000004", "Starting recording check against dontcare") in new stack
  134. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Faktortel-00000004", "dontcare") in new stack
  135. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
  136. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Faktortel-00000004", "") in new stack
  137. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@sub-record-check:20] Return("PJSIP/Faktortel-00000004", "") in new stack
  138. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:13] Set("PJSIP/Faktortel-00000004", "RingGroupMethod=ringall") in new stack
  139. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:14] Set("PJSIP/Faktortel-00000004", "__ALT_CONFIRM_MSG=") in new stack
  140. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:15] GotoIf("PJSIP/Faktortel-00000004", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
  141. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (ext-group,3000,18)
  142. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [3000@ext-group:18] Macro("PJSIP/Faktortel-00000004", "dial,60,HhTtrQ(NO_ANSWER),2000-2002-2003-2004-2001") in new stack
  143. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:1] NoOp("PJSIP/Faktortel-00000004", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
  144. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:2] Set("PJSIP/Faktortel-00000004", "__CRM_SOURCE=0266913905") in new stack
  145. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:3] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ALERT_INFO=)") in new stack
  146. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:4] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ALERT_INFO=)") in new stack
  147. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:5] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ALERT_INFO=)") in new stack
  148. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:6] ExecIf("PJSIP/Faktortel-00000004", "0?Set(CHANNEL(musicclass)=)") in new stack
  149. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:7] AGI("PJSIP/Faktortel-00000004", "agi://127.0.0.1/dialparties.agi") in new stack
  150. [2020-11-25 20:56:01] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Starting New Dialparties.agi
  151. [2020-11-25 20:56:02] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Caller ID name is '0266913905' number is '0266913905'
  152. [2020-11-25 20:56:02] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: CW Ignore is:
  153. [2020-11-25 20:56:02] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: CF Ignore is:
  154. [2020-11-25 20:56:02] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: CW IN_USE/BUSY is: 1
  155. [2020-11-25 20:56:04] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Methodology of ring is  'ringall'
  156. [2020-11-25 20:56:04] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 2000 to extension map
  157. [2020-11-25 20:56:05] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 2002 to extension map
  158. [2020-11-25 20:56:05] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 2003 to extension map
  159. [2020-11-25 20:56:05] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 2004 to extension map
  160. [2020-11-25 20:56:05] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Added extension 2001 to extension map
  161. [2020-11-25 20:56:06] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2000 cf is disabled
  162. [2020-11-25 20:56:06] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2002 cf is disabled
  163. [2020-11-25 20:56:06] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2003 cf is disabled
  164. [2020-11-25 20:56:06] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2004 cf is disabled
  165. [2020-11-25 20:56:07] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2001 cf is disabled
  166. [2020-11-25 20:56:07] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2000 do not disturb is disabled
  167. [2020-11-25 20:56:07] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2002 do not disturb is disabled
  168. [2020-11-25 20:56:07] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2003 do not disturb is disabled
  169. [2020-11-25 20:56:08] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2004 do not disturb is disabled
  170. [2020-11-25 20:56:08] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Extension 2001 do not disturb is disabled
  171. [2020-11-25 20:56:08] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: extnum 2000 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
  172. [2020-11-25 20:56:09] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Discovered PJSIP Endpoint PJSIP/2000
  173. [2020-11-25 20:56:09] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Ended up with real PJSIP Dial string PJSIP/2000/sip:2000@192.168.16.93:5060
  174. [2020-11-25 20:56:09] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/2000 to 0266913905
  175. [2020-11-25 20:56:09] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: extnum 2002 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
  176. [2020-11-25 20:56:10] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Discovered PJSIP Endpoint PJSIP/2002
  177. [2020-11-25 20:56:10] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Ended up with real PJSIP Dial string PJSIP/2002/sip:2002@192.168.16.94:5060
  178. [2020-11-25 20:56:10] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/2002 to 0266913905
  179. [2020-11-25 20:56:11] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: extnum 2003 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
  180. [2020-11-25 20:56:11] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Discovered PJSIP Endpoint PJSIP/2003
  181. [2020-11-25 20:56:11] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Ended up with real PJSIP Dial string PJSIP/2003/sip:2003@192.168.16.96:5060
  182. [2020-11-25 20:56:12] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/2003 to 0266913905
  183. [2020-11-25 20:56:12] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: extnum 2004 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
  184. [2020-11-25 20:56:12] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/2004 to 0266913905
  185. [2020-11-25 20:56:13] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: extnum 2001 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
  186. [2020-11-25 20:56:13] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Discovered PJSIP Endpoint PJSIP/2001
  187. [2020-11-25 20:56:13] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Ended up with real PJSIP Dial string PJSIP/2001/sip:2001@192.168.16.95:5060
  188. [2020-11-25 20:56:13] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/2001 to 0266913905
  189. [2020-11-25 20:56:14] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: Filtered ARG3: 2000-2002-2003-2004-2001
  190. [2020-11-25 20:56:14] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: NODEST: 3000 adding M(auto-blkvm) to dialopts: HhTtrQ(NO_ANSWER)M(auto-blkvm)
  191. [2020-11-25 20:56:14] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: NODEST: 3000 blkvm enabled macro already in dialopts: HhTtrQ(NO_ANSWER)M(auto-blkvm)
  192. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOL_MODE ''
  193. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOL is:
  194. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] res_agi.c: agi://127.0.0.1/dialparties.agi: RVOLPARENT is:
  195. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] res_agi.c: <PJSIP/Faktortel-00000004>AGI Script agi://127.0.0.1/dialparties.agi completed, returning 0
  196. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:8] GotoIf("PJSIP/Faktortel-00000004", "1?normdial") in new stack
  197. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-dial,s,11)
  198. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:11] NoOp("PJSIP/Faktortel-00000004", "Returned from dialparties with groups to dial") in new stack
  199. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:12] NoOp("PJSIP/Faktortel-00000004", "ringall array  ") in new stack
  200. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:13] Set("PJSIP/Faktortel-00000004", "__FMGL_DIAL=") in new stack
  201. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:14] Set("PJSIP/Faktortel-00000004", "LOOPCNT=5") in new stack
  202. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:15] Set("PJSIP/Faktortel-00000004", "ITER=1") in new stack
  203. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:16] Set("PJSIP/Faktortel-00000004", "__EXTTOCALL=2000") in new stack
  204. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:17] NoOp("PJSIP/Faktortel-00000004", "Working with 2000") in new stack
  205. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  206. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:19] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  207. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:20] Set("PJSIP/Faktortel-00000004", "ITER=2") in new stack
  208. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:21] GotoIf("PJSIP/Faktortel-00000004", "1?ndloopbegin") in new stack
  209. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-dial,s,16)
  210. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:16] Set("PJSIP/Faktortel-00000004", "__EXTTOCALL=2002") in new stack
  211. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:17] NoOp("PJSIP/Faktortel-00000004", "Working with 2002") in new stack
  212. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  213. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:19] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  214. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:20] Set("PJSIP/Faktortel-00000004", "ITER=3") in new stack
  215. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:21] GotoIf("PJSIP/Faktortel-00000004", "1?ndloopbegin") in new stack
  216. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-dial,s,16)
  217. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:16] Set("PJSIP/Faktortel-00000004", "__EXTTOCALL=2003") in new stack
  218. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:17] NoOp("PJSIP/Faktortel-00000004", "Working with 2003") in new stack
  219. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  220. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:19] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  221. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:20] Set("PJSIP/Faktortel-00000004", "ITER=4") in new stack
  222. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:21] GotoIf("PJSIP/Faktortel-00000004", "1?ndloopbegin") in new stack
  223. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-dial,s,16)
  224. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:16] Set("PJSIP/Faktortel-00000004", "__EXTTOCALL=2004") in new stack
  225. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:17] NoOp("PJSIP/Faktortel-00000004", "Working with 2004") in new stack
  226. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  227. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:19] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  228. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:20] Set("PJSIP/Faktortel-00000004", "ITER=5") in new stack
  229. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:21] GotoIf("PJSIP/Faktortel-00000004", "1?ndloopbegin") in new stack
  230. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-dial,s,16)
  231. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:16] Set("PJSIP/Faktortel-00000004", "__EXTTOCALL=2001") in new stack
  232. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:17] NoOp("PJSIP/Faktortel-00000004", "Working with 2001") in new stack
  233. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:18] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  234. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:19] ExecIf("PJSIP/Faktortel-00000004", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
  235. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:20] Set("PJSIP/Faktortel-00000004", "ITER=6") in new stack
  236. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:21] GotoIf("PJSIP/Faktortel-00000004", "0?ndloopbegin") in new stack
  237. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:22] Macro("PJSIP/Faktortel-00000004", "dial-ringall-predial-hook,") in new stack
  238. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("PJSIP/Faktortel-00000004", "") in new stack
  239. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:23] ExecIf("PJSIP/Faktortel-00000004", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
  240. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:24] ExecIf("PJSIP/Faktortel-00000004", "0?Set(ds=PJSIP/2000/sip:2000@192.168.16.93:5060&PJSIP/2002/sip:2002@192.168.16.94:5060&PJSIP/2003/sip:2003@192.168.16.96:5060&SIP/2004&PJSIP/2001/sip:2001@192.168.16.95:5060,60,HhtrQ(NO_ANSWER)M(auto-blkvm)g)") in new stack
  241. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-dial:25] Dial("PJSIP/Faktortel-00000004", "PJSIP/2000/sip:2000@192.168.16.93:5060&PJSIP/2002/sip:2002@192.168.16.94:5060&PJSIP/2003/sip:2003@192.168.16.96:5060&SIP/2004&PJSIP/2001/sip:2001@192.168.16.95:5060,60,HhtrQ(NO_ANSWER)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
  242. [2020-11-25 20:56:15] WARNING[4673][C-00000002] chan_sip.c: Purely numeric hostname (2004), and not a peer--rejecting!
  243. [2020-11-25 20:56:15] WARNING[4673][C-00000002] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent)
  244. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2000-00000005 Internal Gosub(func-apply-sipheaders,s,1) start
  245. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/2000-00000005", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  246. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/2000-00000005", "Applying SIP Headers to channel PJSIP/2000-00000005") in new stack
  247. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/2000-00000005", "TECH=PJSIP") in new stack
  248. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/2000-00000005", "SIPHEADERKEYS=") in new stack
  249. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/2000-00000005", "0") in new stack
  250. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_while.c: Jumping to priority 13
  251. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/2000-00000005", "") in new stack
  252. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2000-00000005'
  253. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2000-00000005 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  254. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2002-00000006 Internal Gosub(func-apply-sipheaders,s,1) start
  255. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/2002-00000006", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  256. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/2002-00000006", "Applying SIP Headers to channel PJSIP/2002-00000006") in new stack
  257. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/2002-00000006", "TECH=PJSIP") in new stack
  258. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/2002-00000006", "SIPHEADERKEYS=") in new stack
  259. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/2002-00000006", "0") in new stack
  260. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_while.c: Jumping to priority 13
  261. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/2002-00000006", "") in new stack
  262. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2002-00000006'
  263. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2002-00000006 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  264. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2003-00000007 Internal Gosub(func-apply-sipheaders,s,1) start
  265. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/2003-00000007", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  266. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/2003-00000007", "Applying SIP Headers to channel PJSIP/2003-00000007") in new stack
  267. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/2003-00000007", "TECH=PJSIP") in new stack
  268. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/2003-00000007", "SIPHEADERKEYS=") in new stack
  269. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/2003-00000007", "0") in new stack
  270. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_while.c: Jumping to priority 13
  271. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/2003-00000007", "") in new stack
  272. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2003-00000007'
  273. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2003-00000007 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  274. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2001-00000008 Internal Gosub(func-apply-sipheaders,s,1) start
  275. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/2001-00000008", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  276. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/2001-00000008", "Applying SIP Headers to channel PJSIP/2001-00000008") in new stack
  277. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/2001-00000008", "TECH=PJSIP") in new stack
  278. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/2001-00000008", "SIPHEADERKEYS=") in new stack
  279. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/2001-00000008", "0") in new stack
  280. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_while.c: Jumping to priority 13
  281. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/2001-00000008", "") in new stack
  282. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2001-00000008'
  283. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2001-00000008 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
  284. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: Called PJSIP/2000/sip:2000@192.168.16.93:5060
  285. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: Called PJSIP/2002/sip:2002@192.168.16.94:5060
  286. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: Called PJSIP/2003/sip:2003@192.168.16.96:5060
  287. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: Called PJSIP/2001/sip:2001@192.168.16.95:5060
  288. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184
  289. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio CoS mark 5
  290. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184
  291. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  292. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio CoS mark 5
  293. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184
  294. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  295. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio CoS mark 5
  296. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184
  297. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
  298. [2020-11-25 20:56:15] VERBOSE[2457] netsock2.c: Using SIP RTP Audio CoS mark 5
  299. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2001-00000008 connected line has changed. Saving it until answer for PJSIP/Faktortel-00000004
  300. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2003-00000007 connected line has changed. Saving it until answer for PJSIP/Faktortel-00000004
  301. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2002-00000006 connected line has changed. Saving it until answer for PJSIP/Faktortel-00000004
  302. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2000-00000005 connected line has changed. Saving it until answer for PJSIP/Faktortel-00000004
  303. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2003-00000007 is ringing
  304. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2003-00000007 is ringing
  305. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2001-00000008 is ringing
  306. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2001-00000008 is ringing
  307. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2000-00000005 is ringing
  308. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2000-00000005 is ringing
  309. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2002-00000006 is ringing
  310. [2020-11-25 20:56:15] VERBOSE[4673][C-00000002] app_dial.c: PJSIP/2002-00000006 is ringing
  311. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2000-00000005 Internal Gosub(crm-hangup,s,1) start
  312. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/2000-00000005", "Sending Hangup to CRM") in new stack
  313. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/2000-00000005", "HANGUP CAUSE: 0") in new stack
  314. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/2000-00000005", "0?Set(__CRM_VOICEMAIL=)") in new stack
  315. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/2000-00000005", "MASTER CHANNEL: 1606298175.5 = 1606298161.4") in new stack
  316. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/2000-00000005", "1?return") in new stack
  317. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (crm-hangup,s,8)
  318. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/2000-00000005", "") in new stack
  319. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2000-00000005'
  320. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2000-00000005 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  321. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2002-00000006 Internal Gosub(crm-hangup,s,1) start
  322. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/2002-00000006", "Sending Hangup to CRM") in new stack
  323. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/2002-00000006", "HANGUP CAUSE: 0") in new stack
  324. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/2002-00000006", "0?Set(__CRM_VOICEMAIL=)") in new stack
  325. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/2002-00000006", "MASTER CHANNEL: 1606298175.6 = 1606298161.4") in new stack
  326. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/2002-00000006", "1?return") in new stack
  327. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (crm-hangup,s,8)
  328. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/2002-00000006", "") in new stack
  329. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2002-00000006'
  330. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2002-00000006 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  331. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2003-00000007 Internal Gosub(crm-hangup,s,1) start
  332. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/2003-00000007", "Sending Hangup to CRM") in new stack
  333. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/2003-00000007", "HANGUP CAUSE: 0") in new stack
  334. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/2003-00000007", "0?Set(__CRM_VOICEMAIL=)") in new stack
  335. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/2003-00000007", "MASTER CHANNEL: 1606298175.7 = 1606298161.4") in new stack
  336. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/2003-00000007", "1?return") in new stack
  337. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (crm-hangup,s,8)
  338. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/2003-00000007", "") in new stack
  339. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2003-00000007'
  340. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2003-00000007 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  341. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2001-00000008 Internal Gosub(crm-hangup,s,1) start
  342. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/2001-00000008", "Sending Hangup to CRM") in new stack
  343. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/2001-00000008", "HANGUP CAUSE: 0") in new stack
  344. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/2001-00000008", "0?Set(__CRM_VOICEMAIL=)") in new stack
  345. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/2001-00000008", "MASTER CHANNEL: 1606298175.8 = 1606298161.4") in new stack
  346. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/2001-00000008", "1?return") in new stack
  347. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (crm-hangup,s,8)
  348. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/2001-00000008", "") in new stack
  349. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (from-internal, 3000, 1) exited non-zero on 'PJSIP/2001-00000008'
  350. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/2001-00000008 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
  351. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_macro.c: Spawn extension (macro-dial, s, 25) exited non-zero on 'PJSIP/Faktortel-00000004' in macro 'dial'
  352. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Spawn extension (ext-group, 3000, 18) exited non-zero on 'PJSIP/Faktortel-00000004'
  353. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [h@ext-group:1] Macro("PJSIP/Faktortel-00000004", "hangupcall,") in new stack
  354. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/Faktortel-00000004", "1?theend") in new stack
  355. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-hangupcall,s,3)
  356. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/Faktortel-00000004", "0?Set(CDR(recordingfile)=)") in new stack
  357. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/Faktortel-00000004", "PJSIP/2001-00000008 montior file= ") in new stack
  358. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/Faktortel-00000004", "1?skipagi") in new stack
  359. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx_builtins.c: Goto (macro-hangupcall,s,7)
  360. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/Faktortel-00000004", "") in new stack
  361. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/Faktortel-00000004' in macro 'hangupcall'
  362. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'PJSIP/Faktortel-00000004'
  363. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/Faktortel-00000004 Internal Gosub(crm-hangup,s,1) start
  364. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/Faktortel-00000004", "Sending Hangup to CRM") in new stack
  365. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/Faktortel-00000004", "HANGUP CAUSE: 102") in new stack
  366. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/Faktortel-00000004", "0?Set(__CRM_VOICEMAIL=)") in new stack
  367. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/Faktortel-00000004", "MASTER CHANNEL: 1606298161.4 = 1606298161.4") in new stack
  368. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/Faktortel-00000004", "0?return") in new stack
  369. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/Faktortel-00000004", "__CRM_HANGUP=1") in new stack
  370. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/Faktortel-00000004", "agi://127.0.0.1/sangomacrm.agi") in new stack
  371. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] res_agi.c: <PJSIP/Faktortel-00000004>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  372. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/Faktortel-00000004", "") in new stack
  373. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: Spawn extension (ext-group, h, 1) exited non-zero on 'PJSIP/Faktortel-00000004'
  374. [2020-11-25 20:56:31] VERBOSE[4673][C-00000002] app_stack.c: PJSIP/Faktortel-00000004 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

Reply to "Failed incoming call after 30 seconds"

Here you can reply to the paste above