Re: Cisco 7945 unable to join two calls together

From Lance Oreste, 10 Months ago, written in Plain Text, viewed 60 times. This paste is a reply to Cisco 7945 unable to join two calls together from Lance Oreste - view diff
URL http://pastebin.freepbx.org/view/d6665184 Embed
Download Paste or View Raw
  1. Supported: replaces,join,sdp-anat,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-5.1.0
  2. Content-Length: 310
  3. Content-Type: application/sdp
  4. Content-Disposition: session;handling=optional
  5.  
  6. v=0
  7. o=Cisco-SIPUA 760 0 IN IP4 10.1.212.11
  8. s=SIP Call
  9. t=0 0
  10. m=audio 0 RTP/AVP 8 0 18 102 116 101
  11. a=rtpmap:8 PCMA/8000
  12. a=rtpmap:0 PCMU/8000
  13. a=rtpmap:18 G729/8000
  14. a=fmtp:18 annexb=no
  15. a=rtpmap:102 L16/16000
  16. a=rtpmap:116 iLBC/8000
  17. a=fmtp:116 mode=20
  18. a=rtpmap:101 telephone-event/8000
  19. a=fmtp:101 0-15
  20. <------------->
  21. --- (17 headers 14 lines) ---
  22. Really destroying SIP dialog '4ae34743488e5664308709fd6372a3ac@10.101.10.60:5060' Method: OPTIONS
  23. Reliably Transmitting (no NAT) to 10.1.212.13:5060:
  24. OPTIONS sip:8984@10.1.212.13:5060;transport=udp SIP/2.0
  25. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK5353f6c8
  26. Max-Forwards: 70
  27. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as5027f9a9
  28. To: <sip:8984@10.1.212.13:5060;transport=udp>
  29. Contact: <sip:Unknown@10.101.10.60:5060>
  30. Call-ID: 4dbf38c0434bed146f595ad321b99878@10.101.10.60:5060
  31. CSeq: 102 OPTIONS
  32. User-Agent: FPBX-12.0.76.4(13.14.0)
  33. Date: Mon, 20 Feb 2017 19:49:56 GMT
  34. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  35. Supported: replaces, timer
  36. Content-Length: 0
  37.  
  38.  
  39. ---
  40.  
  41. <--- SIP read from UDP:10.1.212.13:49950 --->
  42. SIP/2.0 200 OK
  43. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK5353f6c8
  44. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as5027f9a9
  45. To: <sip:8984@10.1.212.13:5060;transport=udp>;tag=081735144cdc003fd9291cef-eae71854
  46. Call-ID: 4dbf38c0434bed146f595ad321b99878@10.101.10.60:5060
  47. Date: Mon, 20 Feb 2017 19:49:56 GMT
  48. CSeq: 102 OPTIONS
  49. Server: Cisco-CP7945G/9.3.1
  50. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE
  51. Allow-Events: kpml,dialog,refer
  52. Accept: application/sdp,multipart/mixed,multipart/alternative
  53. Accept-Encoding: identity
  54. Accept-Language: en
  55. Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.0
  56. Content-Length: 311
  57. Content-Type: application/sdp
  58. Content-Disposition: session;handling=optional
  59.  
  60. v=0
  61. o=Cisco-SIPUA 1671 0 IN IP4 10.1.212.13
  62. s=SIP Call
  63. t=0 0
  64. m=audio 0 RTP/AVP 8 0 18 102 116 101
  65. a=rtpmap:8 PCMA/8000
  66. a=rtpmap:0 PCMU/8000
  67. a=rtpmap:18 G729/8000
  68. a=fmtp:18 annexb=no
  69. a=rtpmap:102 L16/16000
  70. a=rtpmap:116 iLBC/8000
  71. a=fmtp:116 mode=20
  72. a=rtpmap:101 telephone-event/8000
  73. a=fmtp:101 0-15
  74. <------------->
  75. --- (17 headers 14 lines) ---
  76. Really destroying SIP dialog '4dbf38c0434bed146f595ad321b99878@10.101.10.60:5060' Method: OPTIONS
  77. Reliably Transmitting (no NAT) to 10.1.212.11:5060:
  78. OPTIONS sip:8985@10.1.212.11:5060;transport=udp SIP/2.0
  79. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK7a580578
  80. Max-Forwards: 70
  81. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as045acf32
  82. To: <sip:8985@10.1.212.11:5060;transport=udp>
  83. Contact: <sip:Unknown@10.101.10.60:5060>
  84. Call-ID: 3eeebb45262f5e1c49d8f5ec0e6251b4@10.101.10.60:5060
  85. CSeq: 102 OPTIONS
  86. User-Agent: FPBX-12.0.76.4(13.14.0)
  87. Date: Mon, 20 Feb 2017 19:49:56 GMT
  88. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  89. Supported: replaces, timer
  90. Content-Length: 0
  91.  
  92.  
  93. ---
  94.  
  95. <--- SIP read from UDP:10.1.212.11:49302 --->
  96. SIP/2.0 200 OK
  97. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK7a580578
  98. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as045acf32
  99. To: <sip:8985@10.1.212.11:5060;transport=udp>;tag=f47f35a2ad43003ee4180298-b0395cc0
  100. Call-ID: 3eeebb45262f5e1c49d8f5ec0e6251b4@10.101.10.60:5060
  101. Date: Mon, 20 Feb 2017 19:49:56 GMT
  102. CSeq: 102 OPTIONS
  103. Server: Cisco-CP7975G/9.2.1
  104. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE
  105. Allow-Events: kpml,dialog,refer
  106. Accept: application/sdp,multipart/mixed,multipart/alternative
  107. Accept-Encoding: identity
  108. Accept-Language: en
  109. Supported: replaces,join,sdp-anat,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-5.1.0
  110. Content-Length: 310
  111. Content-Type: application/sdp
  112. Content-Disposition: session;handling=optional
  113.  
  114. v=0
  115. o=Cisco-SIPUA 972 0 IN IP4 10.1.212.11
  116. s=SIP Call
  117. t=0 0
  118. m=audio 0 RTP/AVP 8 0 18 102 116 101
  119. a=rtpmap:8 PCMA/8000
  120. a=rtpmap:0 PCMU/8000
  121. a=rtpmap:18 G729/8000
  122. a=fmtp:18 annexb=no
  123. a=rtpmap:102 L16/16000
  124. a=rtpmap:116 iLBC/8000
  125. a=fmtp:116 mode=20
  126. a=rtpmap:101 telephone-event/8000
  127. a=fmtp:101 0-15
  128. <------------->
  129. --- (17 headers 14 lines) ---
  130. Really destroying SIP dialog '3eeebb45262f5e1c49d8f5ec0e6251b4@10.101.10.60:5060' Method: OPTIONS
  131. Reliably Transmitting (no NAT) to 10.1.212.13:5060:
  132. OPTIONS sip:1096@10.1.212.13:5060;transport=udp SIP/2.0
  133. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK6ce8ab01
  134. Max-Forwards: 70
  135. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as5b7c4470
  136. To: <sip:1096@10.1.212.13:5060;transport=udp>
  137. Contact: <sip:Unknown@10.101.10.60:5060>
  138. Call-ID: 7c8a97546f55a8c512abff850eb62ab2@10.101.10.60:5060
  139. CSeq: 102 OPTIONS
  140. User-Agent: FPBX-12.0.76.4(13.14.0)
  141. Date: Mon, 20 Feb 2017 19:49:56 GMT
  142. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  143. Supported: replaces, timer
  144. Content-Length: 0
  145.  
  146.  
  147. ---
  148.  
  149. <--- SIP read from UDP:10.1.212.13:51014 --->
  150. SIP/2.0 200 OK
  151. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK6ce8ab01
  152. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as5b7c4470
  153. To: <sip:1096@10.1.212.13:5060;transport=udp>;tag=081735144cdc0040eecd1400-47e32a9d
  154. Call-ID: 7c8a97546f55a8c512abff850eb62ab2@10.101.10.60:5060
  155. Date: Mon, 20 Feb 2017 19:49:56 GMT
  156. CSeq: 102 OPTIONS
  157. Server: Cisco-CP7945G/9.3.1
  158. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE
  159. Allow-Events: kpml,dialog,refer
  160. Accept: application/sdp,multipart/mixed,multipart/alternative
  161. Accept-Encoding: identity
  162. Accept-Language: en
  163. Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.0
  164. Content-Length: 311
  165. Content-Type: application/sdp
  166. Content-Disposition: session;handling=optional
  167.  
  168. v=0
  169. o=Cisco-SIPUA 6321 0 IN IP4 10.1.212.13
  170. s=SIP Call
  171. t=0 0
  172. m=audio 0 RTP/AVP 8 0 18 102 116 101
  173. a=rtpmap:8 PCMA/8000
  174. a=rtpmap:0 PCMU/8000
  175. a=rtpmap:18 G729/8000
  176. a=fmtp:18 annexb=no
  177. a=rtpmap:102 L16/16000
  178. a=rtpmap:116 iLBC/8000
  179. a=fmtp:116 mode=20
  180. a=rtpmap:101 telephone-event/8000
  181. a=fmtp:101 0-15
  182. <------------->
  183. --- (17 headers 14 lines) ---
  184. Really destroying SIP dialog '7c8a97546f55a8c512abff850eb62ab2@10.101.10.60:5060' Method: OPTIONS
  185. Reliably Transmitting (no NAT) to 10.1.20.55:5060:
  186. OPTIONS sip:10.1.20.55 SIP/2.0
  187. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK28435491
  188. Max-Forwards: 70
  189. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as0037ecf2
  190. To: <sip:10.1.20.55>
  191. Contact: <sip:Unknown@10.101.10.60:5060>
  192. Call-ID: 1e78bb014299e58a758c05206346a8e0@10.101.10.60:5060
  193. CSeq: 102 OPTIONS
  194. User-Agent: FPBX-12.0.76.4(13.14.0)
  195. Date: Mon, 20 Feb 2017 19:49:58 GMT
  196. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  197. Supported: replaces, timer
  198. Content-Length: 0
  199.  
  200.  
  201. ---
  202.  
  203. <--- SIP read from UDP:10.1.20.55:5060 --->
  204. SIP/2.0 200 We are in Great Healthworks
  205. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK28435491
  206. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as0037ecf2
  207. To: <sip:10.1.20.55>;tag=8f5c2f5ca380673cf09a7d0d10c51cb2.b055
  208. Call-ID: 1e78bb014299e58a758c05206346a8e0@10.101.10.60:5060
  209. CSeq: 102 OPTIONS
  210. Server: Great HealthWorks Kamailio 4.4
  211. Content-Length: 0
  212.  
  213. <------------->
  214. --- (8 headers 0 lines) ---
  215. Really destroying SIP dialog '1e78bb014299e58a758c05206346a8e0@10.101.10.60:5060' Method: OPTIONS
  216. Reliably Transmitting (no NAT) to 10.1.212.10:5060:
  217. OPTIONS sip:1143@10.1.212.10:5060;transport=udp SIP/2.0
  218. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK361376b9
  219. Max-Forwards: 70
  220. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as67f299a3
  221. To: <sip:1143@10.1.212.10:5060;transport=udp>
  222. Contact: <sip:Unknown@10.101.10.60:5060>
  223. Call-ID: 420af58c239ffb2b59f68301028a1f40@10.101.10.60:5060
  224. CSeq: 102 OPTIONS
  225. User-Agent: FPBX-12.0.76.4(13.14.0)
  226. Date: Mon, 20 Feb 2017 19:49:58 GMT
  227. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  228. Supported: replaces, timer
  229. Content-Length: 0
  230.  
  231.  
  232. ---
  233.  
  234. <--- SIP read from UDP:10.1.212.10:49257 --->
  235. SIP/2.0 200 OK
  236. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK361376b9
  237. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as67f299a3
  238. To: <sip:1143@10.1.212.10:5060;transport=udp>;tag=8cb64ff76905003faabb91a2-8811800d
  239. Call-ID: 420af58c239ffb2b59f68301028a1f40@10.101.10.60:5060
  240. Date: Mon, 20 Feb 2017 19:49:58 GMT
  241. CSeq: 102 OPTIONS
  242. Server: Cisco-CP7942G/8.5.3
  243. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE
  244. Allow-Events: kpml,dialog,refer
  245. Accept: application/sdp,multipart/mixed,multipart/alternative
  246. Accept-Encoding: identity
  247. Accept-Language: en
  248. Supported: replaces,join,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-3.0.0
  249. Content-Length: 284
  250. Content-Type: application/sdp
  251. Content-Disposition: session;handling=optional
  252.  
  253. v=0
  254. o=Cisco-SIPUA 22438 0 IN IP4 10.1.212.10
  255. s=SIP Call
  256. t=0 0
  257. m=audio 0 RTP/AVP 8 0 18 116 101
  258. a=rtpmap:8 PCMA/8000
  259. a=rtpmap:0 PCMU/8000
  260. a=rtpmap:18 G729/8000
  261. a=fmtp:18 annexb=no
  262. a=rtpmap:116 iLBC/8000
  263. a=fmtp:116 mode=20
  264. a=rtpmap:101 telephone-event/8000
  265. a=fmtp:101 0-15
  266. <------------->
  267. --- (17 headers 13 lines) ---
  268. Really destroying SIP dialog '420af58c239ffb2b59f68301028a1f40@10.101.10.60:5060' Method: OPTIONS
  269.  
  270. <--- SIP read from UDP:10.1.20.100:5060 --->
  271. OPTIONS sip:10.101.10.60 SIP/2.0
  272. Via: SIP/2.0/UDP 10.1.20.100:5060;branch=z9hG4bK1e5334dd
  273. Max-Forwards: 70
  274. From: "asterisk" <sip:asterisk@10.1.20.100>;tag=as2ac3f90c
  275. To: <sip:10.101.10.60>
  276. Contact: <sip:asterisk@10.1.20.100:5060>
  277. Call-ID: 0b4ed02a73b82400405e624c4c5153ce@10.1.20.100:5060
  278. CSeq: 102 OPTIONS
  279. User-Agent: Asterisk PBX GIT-13-13.12.2-311-g56e925f
  280. Date: Mon, 20 Feb 2017 19:49:58 GMT
  281. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  282. Supported: replaces, timer
  283. Content-Length: 0
  284.  
  285. <------------->
  286. --- (13 headers 0 lines) ---
  287. Sending to 10.1.20.100:5060 (no NAT)
  288. Looking for s in from-sip-external (domain 10.101.10.60)
  289.  
  290. <--- Transmitting (no NAT) to 10.1.20.100:5060 --->
  291. SIP/2.0 200 OK
  292. Via: SIP/2.0/UDP 10.1.20.100:5060;branch=z9hG4bK1e5334dd;received=10.1.20.100
  293. From: "asterisk" <sip:asterisk@10.1.20.100>;tag=as2ac3f90c
  294. To: <sip:10.101.10.60>;tag=as757a42f8
  295. Call-ID: 0b4ed02a73b82400405e624c4c5153ce@10.1.20.100:5060
  296. CSeq: 102 OPTIONS
  297. Server: FPBX-12.0.76.4(13.14.0)
  298. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  299. Supported: replaces, timer
  300. Contact: <sip:10.101.10.60:5060>
  301. Accept: application/sdp
  302. Content-Length: 0
  303.  
  304.  
  305. <------------>
  306. Scheduling destruction of SIP dialog '0b4ed02a73b82400405e624c4c5153ce@10.1.20.100:5060' in 32000 ms (Method: OPTIONS)
  307. Reliably Transmitting (no NAT) to 192.131.110.210:5060:
  308. OPTIONS sip:192.131.110.210 SIP/2.0
  309. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK56f4217b
  310. Max-Forwards: 70
  311. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as01254f46
  312. To: <sip:192.131.110.210>
  313. Contact: <sip:Unknown@10.101.10.60:5060>
  314. Call-ID: 0d235a0a4cfebee401aacdd50d60239e@10.101.10.60:5060
  315. CSeq: 102 OPTIONS
  316. User-Agent: FPBX-12.0.76.4(13.14.0)
  317. Date: Mon, 20 Feb 2017 19:49:58 GMT
  318. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  319. Supported: replaces, timer
  320. Content-Length: 0
  321.  
  322.  
  323. ---
  324.  
  325. <--- SIP read from UDP:192.131.110.210:5060 --->
  326. SIP/2.0 200 We are in Great Healthworks
  327. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK56f4217b
  328. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as01254f46
  329. To: <sip:192.131.110.210>;tag=8f5c2f5ca380673cf09a7d0d10c51cb2.d53a
  330. Call-ID: 0d235a0a4cfebee401aacdd50d60239e@10.101.10.60:5060
  331. CSeq: 102 OPTIONS
  332. Server: Great HealthWorks Kamailio 4.4
  333. Content-Length: 0
  334.  
  335. <------------->
  336. --- (8 headers 0 lines) ---
  337. Really destroying SIP dialog '0d235a0a4cfebee401aacdd50d60239e@10.101.10.60:5060' Method: OPTIONS
  338.  
  339. <--- SIP read from UDP:10.1.212.12:51917 --->
  340. INVITE sip:8985@10.101.10.60;user=phone SIP/2.0
  341. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bK5b28a739
  342. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  343. To: <sip:8985@10.101.10.60>
  344. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  345. Max-Forwards: 70
  346. Date: Mon, 20 Feb 2017 19:49:59 GMT
  347. CSeq: 101 INVITE
  348. User-Agent: Cisco-CP7965G/9.3.1
  349. Contact: <sip:1068@10.1.212.12:5060;transport=udp>
  350. Expires: 180
  351. Accept: application/sdp
  352. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
  353. Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.0,X-cisco-xsi-8.5.1
  354. Allow-Events: kpml,dialog
  355. Content-Length: 350
  356. Content-Type: application/sdp
  357. Content-Disposition: session;handling=optional
  358.  
  359. v=0
  360. o=Cisco-SIPUA 12089 0 IN IP4 10.1.212.12
  361. s=SIP Call
  362. t=0 0
  363. m=audio 18196 RTP/AVP 8 0 18 102 116 101
  364. c=IN IP4 10.1.212.12
  365. a=rtpmap:8 PCMA/8000
  366. a=rtpmap:0 PCMU/8000
  367. a=rtpmap:18 G729/8000
  368. a=fmtp:18 annexb=no
  369. a=rtpmap:102 L16/16000
  370. a=rtpmap:116 iLBC/8000
  371. a=fmtp:116 mode=20
  372. a=rtpmap:101 telephone-event/8000
  373. a=fmtp:101 0-15
  374. a=sendrecv
  375. <------------->
  376. --- (18 headers 16 lines) ---
  377. Sending to 10.1.212.12:5060 (no NAT)
  378. Sending to 10.1.212.12:5060 (no NAT)
  379. Using INVITE request as basis request - 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  380. Found peer '1068' for '1068' from 10.1.212.12:51917
  381.  
  382. <--- Reliably Transmitting (no NAT) to 10.1.212.12:5060 --->
  383. SIP/2.0 401 Unauthorized
  384. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bK5b28a739;received=10.1.212.12
  385. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  386. To: <sip:8985@10.101.10.60>;tag=as32e10a77
  387. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  388. CSeq: 101 INVITE
  389. Server: FPBX-12.0.76.4(13.14.0)
  390. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  391. Supported: replaces, timer
  392. WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="629702dc"
  393. Content-Length: 0
  394.  
  395.  
  396. <------------>
  397. Scheduling destruction of SIP dialog '0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12' in 6400 ms (Method: INVITE)
  398.  
  399. <--- SIP read from UDP:10.1.212.12:50337 --->
  400. ACK sip:8985@10.101.10.60;user=phone SIP/2.0
  401. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bK5b28a739
  402. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  403. To: <sip:8985@10.101.10.60>;tag=as32e10a77
  404. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  405. Max-Forwards: 70
  406. Date: Mon, 20 Feb 2017 19:49:59 GMT
  407. CSeq: 101 ACK
  408. Content-Length: 0
  409.  
  410. <------------->
  411. --- (9 headers 0 lines) ---
  412.  
  413. <--- SIP read from UDP:10.1.212.12:51917 --->
  414. INVITE sip:8985@10.101.10.60;user=phone SIP/2.0
  415. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc
  416. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  417. To: <sip:8985@10.101.10.60>
  418. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  419. Max-Forwards: 70
  420. Date: Mon, 20 Feb 2017 19:49:59 GMT
  421. CSeq: 102 INVITE
  422. User-Agent: Cisco-CP7965G/9.3.1
  423. Contact: <sip:1068@10.1.212.12:5060;transport=udp>
  424. Authorization: Digest username="1068",realm="asterisk",uri="sip:8985@10.101.10.60;user=phone",response="32f7cd0fd4118dcbf4342966c680e85b",nonce="629702dc",algorithm=MD5
  425. Expires: 180
  426. Accept: application/sdp
  427. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
  428. Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.0,X-cisco-xsi-8.5.1
  429. Allow-Events: kpml,dialog
  430. Content-Length: 350
  431. Content-Type: application/sdp
  432. Content-Disposition: session;handling=optional
  433.  
  434. v=0
  435. o=Cisco-SIPUA 12089 0 IN IP4 10.1.212.12
  436. s=SIP Call
  437. t=0 0
  438. m=audio 18196 RTP/AVP 8 0 18 102 116 101
  439. c=IN IP4 10.1.212.12
  440. a=rtpmap:8 PCMA/8000
  441. a=rtpmap:0 PCMU/8000
  442. a=rtpmap:18 G729/8000
  443. a=fmtp:18 annexb=no
  444. a=rtpmap:102 L16/16000
  445. a=rtpmap:116 iLBC/8000
  446. a=fmtp:116 mode=20
  447. a=rtpmap:101 telephone-event/8000
  448. a=fmtp:101 0-15
  449. a=sendrecv
  450. <------------->
  451. --- (19 headers 16 lines) ---
  452. Sending to 10.1.212.12:5060 (no NAT)
  453. Using INVITE request as basis request - 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  454. Found peer '1068' for '1068' from 10.1.212.12:51917
  455.   == Using SIP RTP TOS bits 184
  456.   == Using SIP RTP CoS mark 5
  457. Found RTP audio format 8
  458. Found RTP audio format 0
  459. Found RTP audio format 18
  460. Found RTP audio format 102
  461. Found RTP audio format 116
  462. Found RTP audio format 101
  463. Found audio description format PCMA for ID 8
  464. Found audio description format PCMU for ID 0
  465. Found audio description format G729 for ID 18
  466. Found audio description format L16 for ID 102
  467. Found audio description format iLBC for ID 116
  468. Found audio description format telephone-event for ID 101
  469. Capabilities: us - (ulaw), peer - audio=(ulaw|alaw|g729|slin16|ilbc)/video=(nothing)/text=(nothing), combined - (ulaw)
  470. Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
  471. Peer audio RTP is at port 10.1.212.12:18196
  472. Looking for 8985 in from-internal (domain 10.101.10.60)
  473. sip_route_dump: route/path hop: <sip:1068@10.1.212.12:5060;transport=udp>
  474.  
  475. <--- Transmitting (no NAT) to 10.1.212.12:5060 --->
  476. SIP/2.0 100 Trying
  477. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  478. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  479. To: <sip:8985@10.101.10.60>
  480. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  481. CSeq: 102 INVITE
  482. Server: FPBX-12.0.76.4(13.14.0)
  483. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  484. Supported: replaces, timer
  485. Contact: <sip:8985@10.101.10.60:5060>
  486. Content-Length: 0
  487.  
  488.  
  489. <------------>
  490.     -- Executing [8985@from-internal:1] Set("SIP/1068-00000004", "__RINGTIMER=15") in new stack
  491.     -- Executing [8985@from-internal:2] Macro("SIP/1068-00000004", "exten-vm,novm,8985,0,0,0") in new stack
  492.     -- Executing [s@macro-exten-vm:1] Macro("SIP/1068-00000004", "user-callerid,") in new stack
  493.     -- Executing [s@macro-user-callerid:1] Set("SIP/1068-00000004", "TOUCH_MONITOR=1487620199.46") in new stack
  494.     -- Executing [s@macro-user-callerid:2] Set("SIP/1068-00000004", "AMPUSER=1068") in new stack
  495.     -- Executing [s@macro-user-callerid:3] GotoIf("SIP/1068-00000004", "0?report") in new stack
  496.     -- Executing [s@macro-user-callerid:4] ExecIf("SIP/1068-00000004", "1?Set(REALCALLERIDNUM=1068)") in new stack
  497.     -- Executing [s@macro-user-callerid:5] Set("SIP/1068-00000004", "AMPUSER=1068") in new stack
  498.     -- Executing [s@macro-user-callerid:6] GotoIf("SIP/1068-00000004", "0?limit") in new stack
  499.     -- Executing [s@macro-user-callerid:7] Set("SIP/1068-00000004", "AMPUSERCIDNAME=Jonathan Cox") in new stack
  500.     -- Executing [s@macro-user-callerid:8] GotoIf("SIP/1068-00000004", "0?report") in new stack
  501.     -- Executing [s@macro-user-callerid:9] Set("SIP/1068-00000004", "AMPUSERCID=1068") in new stack
  502.     -- Executing [s@macro-user-callerid:10] Set("SIP/1068-00000004", "__DIAL_OPTIONS=Ttr") in new stack
  503.     -- Executing [s@macro-user-callerid:11] Set("SIP/1068-00000004", "CALLERID(all)="Jonathan Cox" <1068>") in new stack
  504.     -- Executing [s@macro-user-callerid:12] GotoIf("SIP/1068-00000004", "0?limit") in new stack
  505.     -- Executing [s@macro-user-callerid:13] ExecIf("SIP/1068-00000004", "0?Set(GROUP(concurrency_limit)=1068)") in new stack
  506.     -- Executing [s@macro-user-callerid:14] GosubIf("SIP/1068-00000004", "7?sub-ccss,s,1(macro-exten-vm,8985)") in new stack
  507.     -- Executing [s@sub-ccss:1] ExecIf("SIP/1068-00000004", "0?Return()") in new stack
  508.     -- Executing [s@sub-ccss:2] Set("SIP/1068-00000004", "CCSS_SETUP=TRUE") in new stack
  509.     -- Executing [s@sub-ccss:3] GosubIf("SIP/1068-00000004", "0?monitor_config,1(macro-exten-vm,8985):monitor_default,1(macro-exten-vm,8985)") in new stack
  510.     -- Executing [monitor_default@sub-ccss:1] GotoIf("SIP/1068-00000004", "1?is_exten") in new stack
  511.     -- Goto (sub-ccss,monitor_default,4)
  512.     -- Executing [monitor_default@sub-ccss:4] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_monitor_policy)=generic") in new stack
  513.     -- Executing [monitor_default@sub-ccss:5] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_max_monitors)=5") in new stack
  514.     -- Executing [monitor_default@sub-ccss:6] Return("SIP/1068-00000004", "TRUE") in new stack
  515.     -- Executing [s@sub-ccss:4] GosubIf("SIP/1068-00000004", "7?agent_config,1():agent_default,1()") in new stack
  516.     -- Executing [agent_config@sub-ccss:1] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_agent_policy)=generic") in new stack
  517.     -- Executing [agent_config@sub-ccss:2] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_offer_timer)=30") in new stack
  518.     -- Executing [agent_config@sub-ccss:3] Set("SIP/1068-00000004", "CALLCOMPLETION(ccbs_available_timer)=") in new stack
  519.     -- Executing [agent_config@sub-ccss:4] Set("SIP/1068-00000004", "CALLCOMPLETION(ccnr_available_timer)=") in new stack
  520.     -- Executing [agent_config@sub-ccss:5] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack
  521. [2017-02-20 14:49:59] WARNING[24552][C-00000004]: ccss.c:1012 ast_set_cc_callback_macro: Usage of cc_callback_macro is deprecated.  Please use cc_callback_sub instead.
  522.     -- Executing [agent_config@sub-ccss:6] ExecIf("SIP/1068-00000004", "1?Set(CALLCOMPLETION(cc_recall_timer)=)") in new stack
  523.     -- Executing [agent_config@sub-ccss:7] ExecIf("SIP/1068-00000004", "1?Set(CALLCOMPLETION(cc_max_agents)=)") in new stack
  524.     -- Executing [agent_config@sub-ccss:8] ExecIf("SIP/1068-00000004", "0?Set(CALLCOMPLETION(cc_agent_dialstring)=Local/1068_8985@from-ccss-)") in new stack
  525.     -- Executing [agent_config@sub-ccss:9] Set("SIP/1068-00000004", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack
  526. [2017-02-20 14:49:59] WARNING[24552][C-00000004]: ccss.c:1012 ast_set_cc_callback_macro: Usage of cc_callback_macro is deprecated.  Please use cc_callback_sub instead.
  527.     -- Executing [agent_config@sub-ccss:10] Return("SIP/1068-00000004", "") in new stack
  528.     -- Executing [s@sub-ccss:5] Set("SIP/1068-00000004", "DB(AMPUSER/1068/ccss/last_number)=8985") in new stack
  529.     -- Executing [s@sub-ccss:6] Return("SIP/1068-00000004", "") in new stack
  530.     -- Executing [s@macro-user-callerid:15] GotoIf("SIP/1068-00000004", "0?continue") in new stack
  531.     -- Executing [s@macro-user-callerid:16] Set("SIP/1068-00000004", "__TTL=64") in new stack
  532.     -- Executing [s@macro-user-callerid:17] GotoIf("SIP/1068-00000004", "1?continue") in new stack
  533.     -- Goto (macro-user-callerid,s,28)
  534.     -- Executing [s@macro-user-callerid:28] Set("SIP/1068-00000004", "CALLERID(number)=1068") in new stack
  535.     -- Executing [s@macro-user-callerid:29] Set("SIP/1068-00000004", "CALLERID(name)=Jonathan Cox") in new stack
  536.     -- Executing [s@macro-user-callerid:30] Set("SIP/1068-00000004", "CDR(cnum)=1068") in new stack
  537.     -- Executing [s@macro-user-callerid:31] Set("SIP/1068-00000004", "CDR(cnam)=Jonathan Cox") in new stack
  538.     -- Executing [s@macro-user-callerid:32] Set("SIP/1068-00000004", "CHANNEL(language)=en") in new stack
  539.     -- Executing [s@macro-exten-vm:2] Set("SIP/1068-00000004", "RingGroupMethod=none") in new stack
  540.     -- Executing [s@macro-exten-vm:3] Set("SIP/1068-00000004", "__EXTTOCALL=8985") in new stack
  541.     -- Executing [s@macro-exten-vm:4] Set("SIP/1068-00000004", "__PICKUPMARK=8985") in new stack
  542.     -- Executing [s@macro-exten-vm:5] Set("SIP/1068-00000004", "RT=") in new stack
  543.     -- Executing [s@macro-exten-vm:6] Gosub("SIP/1068-00000004", "sub-record-check,s,1(exten,8985,dontcare)") in new stack
  544.     -- Executing [s@sub-record-check:1] GotoIf("SIP/1068-00000004", "0?initialized") in new stack
  545.     -- Executing [s@sub-record-check:2] Set("SIP/1068-00000004", "__REC_STATUS=INITIALIZED") in new stack
  546.     -- Executing [s@sub-record-check:3] Set("SIP/1068-00000004", "NOW=1487620199") in new stack
  547.     -- Executing [s@sub-record-check:4] Set("SIP/1068-00000004", "__DAY=20") in new stack
  548.     -- Executing [s@sub-record-check:5] Set("SIP/1068-00000004", "__MONTH=02") in new stack
  549.     -- Executing [s@sub-record-check:6] Set("SIP/1068-00000004", "__YEAR=2017") in new stack
  550.     -- Executing [s@sub-record-check:7] Set("SIP/1068-00000004", "__TIMESTR=20170220-144959") in new stack
  551.     -- Executing [s@sub-record-check:8] Set("SIP/1068-00000004", "__FROMEXTEN=1068") in new stack
  552.     -- Executing [s@sub-record-check:9] Set("SIP/1068-00000004", "__MON_FMT=wav") in new stack
  553.     -- Executing [s@sub-record-check:10] NoOp("SIP/1068-00000004", "Recordings initialized") in new stack
  554.     -- Executing [s@sub-record-check:11] ExecIf("SIP/1068-00000004", "0?Set(ARG3=dontcare)") in new stack
  555.     -- Executing [s@sub-record-check:12] Set("SIP/1068-00000004", "REC_POLICY_MODE_SAVE=") in new stack
  556.     -- Executing [s@sub-record-check:13] ExecIf("SIP/1068-00000004", "0?Set(REC_STATUS=NO)") in new stack
  557.     -- Executing [s@sub-record-check:14] GotoIf("SIP/1068-00000004", "5?checkaction") in new stack
  558.     -- Goto (sub-record-check,s,17)
  559.     -- Executing [s@sub-record-check:17] GotoIf("SIP/1068-00000004", "1?sub-record-check,exten,1") in new stack
  560.     -- Goto (sub-record-check,exten,1)
  561.     -- Executing [exten@sub-record-check:1] NoOp("SIP/1068-00000004", "Exten Recording Check between 1068 and 8985") in new stack
  562.     -- Executing [exten@sub-record-check:2] Set("SIP/1068-00000004", "CALLTYPE=internal") in new stack
  563.     -- Executing [exten@sub-record-check:3] ExecIf("SIP/1068-00000004", "0?Set(CALLTYPE=)") in new stack
  564.     -- Executing [exten@sub-record-check:4] Set("SIP/1068-00000004", "CALLEE=dontcare") in new stack
  565.     -- Executing [exten@sub-record-check:5] ExecIf("SIP/1068-00000004", "0?Set(CALLEE=dontcare)") in new stack
  566.     -- Executing [exten@sub-record-check:6] GotoIf("SIP/1068-00000004", "0?callee") in new stack
  567.     -- Executing [exten@sub-record-check:7] GotoIf("SIP/1068-00000004", "1?caller") in new stack
  568.     -- Goto (sub-record-check,exten,13)
  569.     -- Executing [exten@sub-record-check:13] Set("SIP/1068-00000004", "RECMODE=dontcare") in new stack
  570.     -- Executing [exten@sub-record-check:14] ExecIf("SIP/1068-00000004", "0?Set(RECMODE=dontcare)") in new stack
  571.     -- Executing [exten@sub-record-check:15] ExecIf("SIP/1068-00000004", "1?Set(RECMODE=dontcare)") in new stack
  572.     -- Executing [exten@sub-record-check:16] Gosub("SIP/1068-00000004", "recordcheck,1(dontcare,internal,8985)") in new stack
  573.     -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/1068-00000004", "Starting recording check against dontcare") in new stack
  574.     -- Executing [recordcheck@sub-record-check:2] Goto("SIP/1068-00000004", "dontcare") in new stack
  575.     -- Goto (sub-record-check,recordcheck,3)
  576.     -- Executing [recordcheck@sub-record-check:3] Return("SIP/1068-00000004", "") in new stack
  577.     -- Executing [exten@sub-record-check:17] Return("SIP/1068-00000004", "") in new stack
  578.     -- Executing [s@macro-exten-vm:7] GotoIf("SIP/1068-00000004", "1?macrodial") in new stack
  579.     -- Goto (macro-exten-vm,s,13)
  580.     -- Executing [s@macro-exten-vm:13] GosubIf("SIP/1068-00000004", "0?clrheader,1()") in new stack
  581.     -- Executing [s@macro-exten-vm:14] Macro("SIP/1068-00000004", "dial-one,,Ttr,8985") in new stack
  582.     -- Executing [s@macro-dial-one:1] Set("SIP/1068-00000004", "DEXTEN=8985") in new stack
  583.     -- Executing [s@macro-dial-one:2] Set("SIP/1068-00000004", "DIALSTATUS_CW=") in new stack
  584.     -- Executing [s@macro-dial-one:3] GosubIf("SIP/1068-00000004", "0?screen,1()") in new stack
  585.     -- Executing [s@macro-dial-one:4] GosubIf("SIP/1068-00000004", "0?cf,1()") in new stack
  586.     -- Executing [s@macro-dial-one:5] GotoIf("SIP/1068-00000004", "1?skip1") in new stack
  587.     -- Goto (macro-dial-one,s,8)
  588.     -- Executing [s@macro-dial-one:8] GotoIf("SIP/1068-00000004", "0?nodial") in new stack
  589.     -- Executing [s@macro-dial-one:9] GotoIf("SIP/1068-00000004", "0?continue") in new stack
  590.     -- Executing [s@macro-dial-one:10] Set("SIP/1068-00000004", "EXTHASCW=ENABLED") in new stack
  591.     -- Executing [s@macro-dial-one:11] GotoIf("SIP/1068-00000004", "0?next1:cwinusebusy") in new stack
  592.     -- Goto (macro-dial-one,s,23)
  593.     -- Executing [s@macro-dial-one:23] GotoIf("SIP/1068-00000004", "1?next3:continue") in new stack
  594.     -- Goto (macro-dial-one,s,24)
  595.     -- Executing [s@macro-dial-one:24] ExecIf("SIP/1068-00000004", "0?Set(DIALSTATUS_CW=BUSY)") in new stack
  596.     -- Executing [s@macro-dial-one:25] GotoIf("SIP/1068-00000004", "0?nodial") in new stack
  597.     -- Executing [s@macro-dial-one:26] GosubIf("SIP/1068-00000004", "1?dstring,1():dlocal,1()") in new stack
  598.     -- Executing [dstring@macro-dial-one:1] Set("SIP/1068-00000004", "DSTRING=") in new stack
  599.     -- Executing [dstring@macro-dial-one:2] Set("SIP/1068-00000004", "DEVICES=8985") in new stack
  600.     -- Executing [dstring@macro-dial-one:3] ExecIf("SIP/1068-00000004", "0?Return()") in new stack
  601.     -- Executing [dstring@macro-dial-one:4] ExecIf("SIP/1068-00000004", "0?Set(DEVICES=985)") in new stack
  602.     -- Executing [dstring@macro-dial-one:5] Set("SIP/1068-00000004", "LOOPCNT=1") in new stack
  603.     -- Executing [dstring@macro-dial-one:6] Set("SIP/1068-00000004", "ITER=1") in new stack
  604.     -- Executing [dstring@macro-dial-one:7] Set("SIP/1068-00000004", "THISDIAL=SIP/8985") in new stack
  605.     -- Executing [dstring@macro-dial-one:8] GosubIf("SIP/1068-00000004", "1?zap2dahdi,1()") in new stack
  606.     -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/1068-00000004", "0?Return()") in new stack
  607.     -- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/1068-00000004", "NEWDIAL=") in new stack
  608.     -- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/1068-00000004", "LOOPCNT2=1") in new stack
  609.     -- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/1068-00000004", "ITER2=1") in new stack
  610.     -- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/1068-00000004", "THISPART2=SIP/8985") in new stack
  611.     -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/1068-00000004", "0?Set(THISPART2=DAHDI/8985)") in new stack
  612.     -- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/1068-00000004", "NEWDIAL=SIP/8985&") in new stack
  613.     -- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/1068-00000004", "ITER2=2") in new stack
  614.     -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/1068-00000004", "0?begin2") in new stack
  615.     -- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/1068-00000004", "THISDIAL=SIP/8985") in new stack
  616.     -- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/1068-00000004", "") in new stack
  617.     -- Executing [dstring@macro-dial-one:9] GotoIf("SIP/1068-00000004", "1?doset") in new stack
  618.     -- Goto (macro-dial-one,dstring,13)
  619.     -- Executing [dstring@macro-dial-one:13] Set("SIP/1068-00000004", "DSTRING=SIP/8985&") in new stack
  620.     -- Executing [dstring@macro-dial-one:14] Set("SIP/1068-00000004", "ITER=2") in new stack
  621.     -- Executing [dstring@macro-dial-one:15] GotoIf("SIP/1068-00000004", "0?begin") in new stack
  622.     -- Executing [dstring@macro-dial-one:16] ExecIf("SIP/1068-00000004", "0?Return()") in new stack
  623.     -- Executing [dstring@macro-dial-one:17] Set("SIP/1068-00000004", "DSTRING=SIP/8985") in new stack
  624.     -- Executing [dstring@macro-dial-one:18] Return("SIP/1068-00000004", "") in new stack
  625.     -- Executing [s@macro-dial-one:27] GotoIf("SIP/1068-00000004", "0?nodial") in new stack
  626.     -- Executing [s@macro-dial-one:28] GotoIf("SIP/1068-00000004", "0?skiptrace") in new stack
  627.     -- Executing [s@macro-dial-one:29] GosubIf("SIP/1068-00000004", "1?ctset,1():ctclear,1()") in new stack
  628.     -- Executing [ctset@macro-dial-one:1] Set("SIP/1068-00000004", "DB(CALLTRACE/8985)=1068") in new stack
  629.     -- Executing [ctset@macro-dial-one:2] Return("SIP/1068-00000004", "") in new stack
  630.     -- Executing [s@macro-dial-one:30] Set("SIP/1068-00000004", "D_OPTIONS=Ttr") in new stack
  631.     -- Executing [s@macro-dial-one:31] ExecIf("SIP/1068-00000004", "0?SIPAddHeader(Alert-Info: )") in new stack
  632.     -- Executing [s@macro-dial-one:32] ExecIf("SIP/1068-00000004", "0?SIPAddHeader()") in new stack
  633.     -- Executing [s@macro-dial-one:33] ExecIf("SIP/1068-00000004", "0?Set(CHANNEL(musicclass)=)") in new stack
  634.     -- Executing [s@macro-dial-one:34] GosubIf("SIP/1068-00000004", "0?qwait,1()") in new stack
  635.     -- Executing [s@macro-dial-one:35] Set("SIP/1068-00000004", "__CWIGNORE=") in new stack
  636.     -- Executing [s@macro-dial-one:36] Set("SIP/1068-00000004", "__KEEPCID=TRUE") in new stack
  637.     -- Executing [s@macro-dial-one:37] GotoIf("SIP/1068-00000004", "0?usegoto,1") in new stack
  638.     -- Executing [s@macro-dial-one:38] GotoIf("SIP/1068-00000004", "0?godial") in new stack
  639.     -- Executing [s@macro-dial-one:39] Gosub("SIP/1068-00000004", "sub-presencestate-display,s,1(8985)") in new stack
  640.     -- Executing [s@sub-presencestate-display:1] Goto("SIP/1068-00000004", "state-not_set,1") in new stack
  641.     -- Goto (sub-presencestate-display,state-not_set,1)
  642.     -- Executing [state-not_set@sub-presencestate-display:1] Set("SIP/1068-00000004", "PRESENCESTATE_DISPLAY=") in new stack
  643.     -- Executing [state-not_set@sub-presencestate-display:2] Return("SIP/1068-00000004", "") in new stack
  644.     -- Executing [s@macro-dial-one:40] Set("SIP/1068-00000004", "CONNECTEDLINE(name,i)=GHWtest2") in new stack
  645.     -- Executing [s@macro-dial-one:41] Set("SIP/1068-00000004", "CONNECTEDLINE(num)=8985") in new stack
  646.     -- Executing [s@macro-dial-one:42] Set("SIP/1068-00000004", "D_OPTIONS=TtrI") in new stack
  647.     -- Executing [s@macro-dial-one:43] Macro("SIP/1068-00000004", "dialout-one-predial-hook,") in new stack
  648.     -- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("SIP/1068-00000004", "") in new stack
  649.     -- Executing [s@macro-dial-one:44] ExecIf("SIP/1068-00000004", "0?Set(D_OPTIONS=trII)") in new stack
  650.     -- Executing [s@macro-dial-one:45] Dial("SIP/1068-00000004", "SIP/8985,,TtrI") in new stack
  651.   == Using SIP RTP TOS bits 184
  652.   == Using SIP RTP CoS mark 5
  653. Audio is at 15716
  654. Adding codec ulaw to SDP
  655. Adding non-codec 0x1 (telephone-event) to SDP
  656. Reliably Transmitting (no NAT) to 10.1.212.11:5060:
  657. INVITE sip:8985@10.1.212.11:5060;transport=udp SIP/2.0
  658. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  659. Max-Forwards: 70
  660. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  661. To: <sip:8985@10.1.212.11:5060;transport=udp>
  662. Contact: <sip:1068@10.101.10.60:5060>
  663. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  664. CSeq: 102 INVITE
  665. User-Agent: FPBX-12.0.76.4(13.14.0)
  666. Date: Mon, 20 Feb 2017 19:49:59 GMT
  667. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  668. Supported: replaces, timer
  669. Content-Type: application/sdp
  670. Content-Length: 252
  671.  
  672. v=0
  673. o=root 1713242149 1713242149 IN IP4 10.101.10.60
  674. s=Asterisk PBX 13.14.0
  675. c=IN IP4 10.101.10.60
  676. t=0 0
  677. m=audio 15716 RTP/AVP 0 101
  678. a=rtpmap:0 PCMU/8000
  679. a=rtpmap:101 telephone-event/8000
  680. a=fmtp:101 0-16
  681. a=ptime:20
  682. a=maxptime:150
  683. a=sendrecv
  684.  
  685. ---
  686.     -- Called SIP/8985
  687.  
  688. <--- Transmitting (no NAT) to 10.1.212.12:5060 --->
  689. SIP/2.0 180 Ringing
  690. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  691. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  692. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  693. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  694. CSeq: 102 INVITE
  695. Server: FPBX-12.0.76.4(13.14.0)
  696. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  697. Supported: replaces, timer
  698. Contact: <sip:8985@10.101.10.60:5060>
  699. Content-Length: 0
  700.  
  701.  
  702. <------------>
  703.     -- Connected line update to SIP/1068-00000004 prevented.
  704.  
  705. <--- SIP read from UDP:10.1.212.11:51821 --->
  706. SIP/2.0 100 Trying
  707. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  708. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  709. To: <sip:8985@10.1.212.11:5060;transport=udp>
  710. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  711. Date: Mon, 20 Feb 2017 19:49:59 GMT
  712. CSeq: 102 INVITE
  713. Server: Cisco-CP7975G/9.2.1
  714. Contact: <sip:1576@10.1.212.11:5060;transport=udp>
  715. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
  716. Supported: replaces,join,sdp-anat,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-5.1.0,X-cisco-xsi-8.5.1
  717. Allow-Events: kpml,dialog
  718. Content-Length: 0
  719.  
  720. <------------->
  721. --- (13 headers 0 lines) ---
  722.  
  723. <--- SIP read from UDP:10.40.1.29:51543 --->
  724.  
  725.  
  726. <------------->
  727.  
  728. <--- SIP read from UDP:10.1.212.11:51821 --->
  729. SIP/2.0 180 Ringing
  730. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  731. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  732. To: <sip:8985@10.1.212.11:5060;transport=udp>;tag=f47f35a2ad43003f60e131e8-13a43990
  733. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  734. Date: Mon, 20 Feb 2017 19:50:00 GMT
  735. CSeq: 102 INVITE
  736. Server: Cisco-CP7975G/9.2.1
  737. Contact: <sip:8985@10.1.212.11:5060;transport=udp>
  738. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
  739. Supported: replaces,join,sdp-anat,norefersub,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-5.1.0,X-cisco-xsi-8.5.1
  740. Allow-Events: kpml,dialog
  741. Content-Length: 0
  742.  
  743. <------------->
  744. --- (13 headers 0 lines) ---
  745. sip_route_dump: route/path hop: <sip:8985@10.1.212.11:5060;transport=udp>
  746.     -- SIP/8985-00000005 is ringing
  747.  
  748. <--- Transmitting (no NAT) to 10.1.212.12:5060 --->
  749. SIP/2.0 180 Ringing
  750. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  751. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  752. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  753. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  754. CSeq: 102 INVITE
  755. Server: FPBX-12.0.76.4(13.14.0)
  756. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  757. Supported: replaces, timer
  758. Contact: <sip:8985@10.101.10.60:5060>
  759. Content-Length: 0
  760.  
  761.  
  762. <------------>
  763.     -- Attempting call on Local/s@tc-maint for application NoCDR() (Retry 1)
  764.     -- Called s@tc-maint
  765.     -- Executing [s@tc-maint:1] NoCDR("Local/s@tc-maint-00000002;2", "") in new stack
  766.     -- Executing [s@tc-maint:2] Set("Local/s@tc-maint-00000002;2", "TCMAINT=RETURN") in new stack
  767.     -- Executing [s@tc-maint:3] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,1,1()") in new stack
  768.     -- Executing [1@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/1/INUSESTATE)=INUSE") in new stack
  769.     -- Executing [1@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
  770.     -- Executing [1@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "18:00-09:00,mon-fri,1-31,jan-dec,America/New_York?truestate") in new stack
  771.     -- Executing [1@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  772.     -- Executing [1@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/1)=)") in new stack
  773.     -- Executing [1@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
  774.     -- Executing [1@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  775.     -- Executing [1@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,3,1") in new stack
  776.     -- Executing [1@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  777.     -- Executing [1@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  778.     -- Executing [1@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  779.     -- Executing [s@tc-maint:4] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,10,1()") in new stack
  780.     -- Executing [10@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/10/INUSESTATE)=INUSE") in new stack
  781.     -- Executing [10@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/10/NOT_INUSESTATE)=NOT_INUSE") in new stack
  782.     -- Executing [10@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,4,jul?truestate") in new stack
  783.     -- Executing [10@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  784.     -- Executing [10@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/10)=)") in new stack
  785.     -- Executing [10@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC10)=INUSE") in new stack
  786.     -- Executing [10@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  787.     -- Executing [10@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?app-blackhole,hangup,1") in new stack
  788.     -- Executing [10@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  789.     -- Executing [10@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  790.     -- Executing [10@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  791.     -- Executing [s@tc-maint:5] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,9,1()") in new stack
  792.     -- Executing [9@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/9/INUSESTATE)=INUSE") in new stack
  793.     -- Executing [9@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/9/NOT_INUSESTATE)=NOT_INUSE") in new stack
  794.     -- Executing [9@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,24-25,nov,America/New_York?truestate") in new stack
  795.     -- Executing [9@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  796.     -- Executing [9@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/9)=)") in new stack
  797.     -- Executing [9@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC9)=INUSE") in new stack
  798.     -- Executing [9@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  799.     -- Executing [9@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?app-blackhole,hangup,1") in new stack
  800.     -- Executing [9@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  801.     -- Executing [9@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  802.     -- Executing [9@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  803.     -- Executing [s@tc-maint:6] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,8,1()") in new stack
  804.     -- Executing [8@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/8/INUSESTATE)=INUSE") in new stack
  805.     -- Executing [8@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/8/NOT_INUSESTATE)=NOT_INUSE") in new stack
  806.     -- Executing [8@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,23-26,dec,America/New_York?truestate") in new stack
  807.     -- Executing [8@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  808.     -- Executing [8@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/8)=)") in new stack
  809.     -- Executing [8@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC8)=INUSE") in new stack
  810.     -- Executing [8@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  811.     -- Executing [8@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,9,1") in new stack
  812.     -- Executing [8@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  813.     -- Executing [8@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  814.     -- Executing [8@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  815.     -- Executing [s@tc-maint:7] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,7,1()") in new stack
  816.     -- Executing [7@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/7/INUSESTATE)=INUSE") in new stack
  817.     -- Executing [7@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/7/NOT_INUSESTATE)=NOT_INUSE") in new stack
  818.     -- Executing [7@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,wed,17,aug?truestate") in new stack
  819.     -- Executing [7@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  820.     -- Executing [7@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/7)=)") in new stack
  821.     -- Executing [7@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC7)=INUSE") in new stack
  822.     -- Executing [7@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  823.     -- Executing [7@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?ext-group,4682,1") in new stack
  824.     -- Executing [7@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  825.     -- Executing [7@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  826.     -- Executing [7@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  827.     -- Executing [s@tc-maint:8] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,6,1()") in new stack
  828.     -- Executing [6@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/6/INUSESTATE)=INUSE") in new stack
  829.     -- Executing [6@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/6/NOT_INUSESTATE)=NOT_INUSE") in new stack
  830.     -- Executing [6@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,sat-sun,*,jan-dec,America/New_York?truestate") in new stack
  831.     -- Executing [6@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  832.     -- Executing [6@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/6)=)") in new stack
  833.     -- Executing [6@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC6)=INUSE") in new stack
  834.     -- Executing [6@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  835.     -- Executing [6@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?directory,1,1") in new stack
  836.     -- Executing [6@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  837.     -- Executing [6@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  838.     -- Executing [6@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  839.     -- Executing [s@tc-maint:9] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,5,1()") in new stack
  840.     -- Executing [5@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/5/INUSESTATE)=INUSE") in new stack
  841.     -- Executing [5@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/5/NOT_INUSESTATE)=NOT_INUSE") in new stack
  842.     -- Executing [5@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,24-25,nov?truestate") in new stack
  843.     -- Executing [5@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  844.     -- Executing [5@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/5)=)") in new stack
  845.     -- Executing [5@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC5)=INUSE") in new stack
  846.     -- Executing [5@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  847.     -- Executing [5@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,6,1") in new stack
  848.     -- Executing [5@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  849.     -- Executing [5@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  850.     -- Executing [5@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  851.     -- Executing [s@tc-maint:10] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,4,1()") in new stack
  852.     -- Executing [4@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/4/INUSESTATE)=INUSE") in new stack
  853.     -- Executing [4@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/4/NOT_INUSESTATE)=NOT_INUSE") in new stack
  854.     -- Executing [4@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,4,jul,America/New_York?truestate") in new stack
  855.     -- Executing [4@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  856.     -- Executing [4@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/4)=)") in new stack
  857.     -- Executing [4@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC4)=INUSE") in new stack
  858.     -- Executing [4@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  859.     -- Executing [4@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,5,1") in new stack
  860.     -- Executing [4@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  861.     -- Executing [4@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  862.     -- Executing [4@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  863.     -- Executing [s@tc-maint:11] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,3,1()") in new stack
  864.     -- Executing [3@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/3/INUSESTATE)=INUSE") in new stack
  865.     -- Executing [3@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/3/NOT_INUSESTATE)=NOT_INUSE") in new stack
  866.     -- Executing [3@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,30-2,dec-jan,America/New_York?truestate") in new stack
  867.     -- Executing [3@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  868.     -- Executing [3@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/3)=)") in new stack
  869.     -- Executing [3@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC3)=INUSE") in new stack
  870.     -- Executing [3@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  871.     -- Executing [3@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,2,1") in new stack
  872.     -- Executing [3@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  873.     -- Executing [3@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  874.     -- Executing [3@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  875.     -- Executing [s@tc-maint:12] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,2,1()") in new stack
  876.     -- Executing [2@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/2/INUSESTATE)=INUSE") in new stack
  877.     -- Executing [2@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/2/NOT_INUSESTATE)=NOT_INUSE") in new stack
  878.     -- Executing [2@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,23-26,dec?truestate") in new stack
  879.     -- Executing [2@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  880.     -- Executing [2@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/2)=)") in new stack
  881.     -- Executing [2@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC2)=INUSE") in new stack
  882.     -- Executing [2@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  883.     -- Executing [2@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,4,1") in new stack
  884.     -- Executing [2@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  885.     -- Executing [2@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  886.     -- Executing [2@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  887.     -- Executing [s@tc-maint:13] Gosub("Local/s@tc-maint-00000002;2", "timeconditions,11,1()") in new stack
  888.     -- Executing [11@timeconditions:1] Set("Local/s@tc-maint-00000002;2", "DB(TC/11/INUSESTATE)=INUSE") in new stack
  889.     -- Executing [11@timeconditions:2] Set("Local/s@tc-maint-00000002;2", "DB(TC/11/NOT_INUSESTATE)=NOT_INUSE") in new stack
  890.     -- Executing [11@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000002;2", "00:00-23:59,*,30-2,dec-jan?truestate") in new stack
  891.     -- Executing [11@timeconditions:4] GotoIf("Local/s@tc-maint-00000002;2", "0?truegoto") in new stack
  892.     -- Executing [11@timeconditions:5] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(DB(TC/11)=)") in new stack
  893.     -- Executing [11@timeconditions:6] Set("Local/s@tc-maint-00000002;2", "DEVICE_STATE(Custom:TC11)=INUSE") in new stack
  894.     -- Executing [11@timeconditions:7] ExecIf("Local/s@tc-maint-00000002;2", "0?Set(NOT_INUSE)") in new stack
  895.     -- Executing [11@timeconditions:8] GotoIf("Local/s@tc-maint-00000002;2", "0?timeconditions,1,1") in new stack
  896.     -- Executing [11@timeconditions:9] Set("Local/s@tc-maint-00000002;2", "TCSTATE=false") in new stack
  897.     -- Executing [11@timeconditions:10] Set("Local/s@tc-maint-00000002;2", "TCOVERRIDE=false") in new stack
  898.     -- Executing [11@timeconditions:11] Return("Local/s@tc-maint-00000002;2", "") in new stack
  899.     -- Executing [s@tc-maint:14] System("Local/s@tc-maint-00000002;2", "/var/lib/asterisk/bin/schedtc.php 60 /var/spool/asterisk/outgoing 1") in new stack
  900.     -- Executing [s@tc-maint:15] Answer("Local/s@tc-maint-00000002;2", "") in new stack
  901.     -- Local/s@tc-maint-00000002;1 answered
  902.   == Spawn extension (tc-maint, s, 15) exited non-zero on 'Local/s@tc-maint-00000002;2'
  903. [2017-02-20 14:50:00] NOTICE[24553]: pbx_spool.c:426 attempt_thread: Call completed to Local/s@tc-maint
  904.  
  905. <--- SIP read from UDP:10.1.212.12:51917 --->
  906. REFER sip:10.101.10.60 SIP/2.0
  907. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKa3b723e3
  908. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a002714a1d828-ce3f24f5
  909. To: <sip:1096@10.101.10.60>
  910. Call-ID: OutOfDialog--000c-e1dd0bd6-2b75f547@10.1.212.12
  911. Max-Forwards: 70
  912. Date: Mon, 20 Feb 2017 19:50:01 GMT
  913. CSeq: 101 REFER
  914. User-Agent: Cisco-CP7965G/9.3.1
  915. Contact: <sip:1068@10.1.212.12:5060;transport=udp>
  916. Referred-By: "1068" <sip:1068@10.101.10.60>
  917. Refer-To: cid:2a79eb42@10.1.212.12
  918. Content-Length: 957
  919. Content-Type: application/x-cisco-remotecc-request+xml
  920. Content-Disposition: session;handling=required
  921. Content-Id: <2a79eb42@10.1.212.12>
  922.  
  923. <?xml version="1.0" encoding="UTF-8"?>
  924. <x-cisco-remotecc-request> <softkeyeventmsg> <softkeyevent>Conference</softkeyevent> <dialogid> <callid>0023eb53-0a6a0009-7968a141-8d5ad8ef@10.1.212.12</callid> <localtag>0023eb530a6a0024bba57645-e73d585b</localtag> <remotetag>as364b2038</remotetag> </dialogid> <linenumber>0</linenumber> <participantnum>0</participantnum> <consultdialogid> <callid>0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12</callid> <localtag>0023eb530a6a00262bd91ae0-4be7b65d</localtag> <remotetag>as7a14e517</remotetag> </consultdialogid> <state>false</state> <joindialogid> <callid></callid> <localtag></localtag> <remotetag></remotetag> </joindialogid> <eventdata> <invocationtype>explicit</invocationtype> </eventdata> <userdata></userdata> <softkeyid>0</softkeyid> <applicationid>0</applicationid> </softkeyeventmsg>
  925. </x-cisco-remotecc-request>
  926. <------------->
  927. --- (16 headers 3 lines) ---
  928. Sending to 10.1.212.12:5060 (no NAT)
  929. Call OutOfDialog--000c-e1dd0bd6-2b75f547@10.1.212.12 got a SIP call transfer from caller: (REFER)!
  930.  
  931. <--- Transmitting (no NAT) to 10.1.212.12:5060 --->
  932. SIP/2.0 603 Declined (No dialog)
  933. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKa3b723e3;received=10.1.212.12
  934. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a002714a1d828-ce3f24f5
  935. To: <sip:1096@10.101.10.60>;tag=as268803f5
  936. Call-ID: OutOfDialog--000c-e1dd0bd6-2b75f547@10.1.212.12
  937. CSeq: 101 REFER
  938. Server: FPBX-12.0.76.4(13.14.0)
  939. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  940. Supported: replaces, timer
  941. Content-Length: 0
  942.  
  943.  
  944. <------------>
  945. Really destroying SIP dialog 'OutOfDialog--000c-e1dd0bd6-2b75f547@10.1.212.12' Method: REFER
  946.  
  947. <--- SIP read from UDP:10.1.212.12:51917 --->
  948. CANCEL sip:8985@10.101.10.60;user=phone SIP/2.0
  949. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc
  950. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  951. To: <sip:8985@10.101.10.60>
  952. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  953. Max-Forwards: 70
  954. Date: Mon, 20 Feb 2017 19:50:04 GMT
  955. CSeq: 102 CANCEL
  956. User-Agent: Cisco-CP7965G/9.3.1
  957. Content-Length: 0
  958. Authorization: Digest username="1068",realm="asterisk",uri="sip:8985@10.101.10.60;user=phone",response="ec2e3e5c1c356aaaeb5e3268237b4755",nonce="629702dc",algorithm=MD5
  959.  
  960. <------------->
  961. --- (11 headers 0 lines) ---
  962. Sending to 10.1.212.12:5060 (no NAT)
  963.  
  964. <--- Reliably Transmitting (no NAT) to 10.1.212.12:5060 --->
  965. SIP/2.0 487 Request Terminated
  966. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  967. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  968. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  969. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  970. CSeq: 102 INVITE
  971. Server: FPBX-12.0.76.4(13.14.0)
  972. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  973. Supported: replaces, timer
  974. Content-Length: 0
  975.  
  976.  
  977. <------------>
  978.  
  979. <--- Transmitting (no NAT) to 10.1.212.12:5060 --->
  980. SIP/2.0 200 OK
  981. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  982. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  983. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  984. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  985. CSeq: 102 CANCEL
  986. Server: FPBX-12.0.76.4(13.14.0)
  987. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  988. Supported: replaces, timer
  989. Content-Length: 0
  990.  
  991.  
  992. <------------>
  993. Scheduling destruction of SIP dialog '1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060' in 6400 ms (Method: INVITE)
  994. Reliably Transmitting (no NAT) to 10.1.212.11:5060:
  995. CANCEL sip:8985@10.1.212.11:5060;transport=udp SIP/2.0
  996. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  997. Max-Forwards: 70
  998. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  999. To: <sip:8985@10.1.212.11:5060;transport=udp>
  1000. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  1001. CSeq: 102 CANCEL
  1002. User-Agent: FPBX-12.0.76.4(13.14.0)
  1003. Content-Length: 0
  1004.  
  1005.  
  1006. ---
  1007. Scheduling destruction of SIP dialog '1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060' in 6400 ms (Method: INVITE)
  1008.   == Spawn extension (macro-dial-one, s, 45) exited non-zero on 'SIP/1068-00000004' in macro 'dial-one'
  1009.   == Spawn extension (macro-exten-vm, s, 14) exited non-zero on 'SIP/1068-00000004' in macro 'exten-vm'
  1010.   == Spawn extension (from-internal, 8985, 2) exited non-zero on 'SIP/1068-00000004'
  1011.     -- Executing [h@from-internal:1] Hangup("SIP/1068-00000004", "") in new stack
  1012.   == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/1068-00000004'
  1013.  
  1014. <--- SIP read from UDP:10.1.212.11:51821 --->
  1015. SIP/2.0 200 OK
  1016. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  1017. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  1018. To: <sip:8985@10.1.212.11:5060;transport=udp>;tag=f47f35a2ad43003f60e131e8-13a43990
  1019. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  1020. Date: Mon, 20 Feb 2017 19:50:04 GMT
  1021. CSeq: 102 CANCEL
  1022. Server: Cisco-CP7975G/9.2.1
  1023. Content-Length: 0
  1024.  
  1025. <------------->
  1026. --- (9 headers 0 lines) ---
  1027.  
  1028. <--- SIP read from UDP:10.1.212.12:51917 --->
  1029. ACK sip:8985@10.101.10.60;user=phone SIP/2.0
  1030. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bK3ea16ff1
  1031. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1032. To: <sip:8985@10.101.10.60>
  1033. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1034. Max-Forwards: 70
  1035. Date: Mon, 20 Feb 2017 19:50:04 GMT
  1036. CSeq: 102 ACK
  1037. User-Agent: Cisco-CP7965G/9.3.1
  1038. Authorization: Digest username="1068",realm="asterisk",uri="sip:8985@10.101.10.60;user=phone",response="ec2e3e5c1c356aaaeb5e3268237b4755",nonce="629702dc",algorithm=MD5
  1039. Content-Length: 0
  1040.  
  1041. <------------->
  1042. --- (11 headers 0 lines) ---
  1043.  
  1044. <--- SIP read from UDP:10.1.212.11:51821 --->
  1045. SIP/2.0 487 Request Cancelled
  1046. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  1047. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  1048. To: <sip:8985@10.1.212.11:5060;transport=udp>;tag=f47f35a2ad43003f60e131e8-13a43990
  1049. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  1050. Date: Mon, 20 Feb 2017 19:50:04 GMT
  1051. CSeq: 102 INVITE
  1052. Server: Cisco-CP7975G/9.2.1
  1053. Contact: <sip:8985@10.1.212.11:5060;transport=udp>
  1054. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
  1055. Allow-Events: kpml,dialog
  1056. Content-Length: 0
  1057.  
  1058. <------------->
  1059. --- (12 headers 0 lines) ---
  1060. Transmitting (no NAT) to 10.1.212.11:5060:
  1061. ACK sip:8985@10.1.212.11:5060;transport=udp SIP/2.0
  1062. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK48e2454f
  1063. Max-Forwards: 70
  1064. From: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as171f41a9
  1065. To: <sip:8985@10.1.212.11:5060;transport=udp>;tag=f47f35a2ad43003f60e131e8-13a43990
  1066. Contact: <sip:1068@10.101.10.60:5060>
  1067. Call-ID: 1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060
  1068. CSeq: 102 ACK
  1069. User-Agent: FPBX-12.0.76.4(13.14.0)
  1070. Content-Length: 0
  1071.  
  1072.  
  1073. ---
  1074. Scheduling destruction of SIP dialog '1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060' in 6400 ms (Method: INVITE)
  1075. Retransmitting #1 (no NAT) to 10.1.212.12:5060:
  1076. SIP/2.0 487 Request Terminated
  1077. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1078. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1079. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1080. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1081. CSeq: 102 INVITE
  1082. Server: FPBX-12.0.76.4(13.14.0)
  1083. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1084. Supported: replaces, timer
  1085. Content-Length: 0
  1086.  
  1087.  
  1088. ---
  1089. Retransmitting #2 (no NAT) to 10.1.212.12:5060:
  1090. SIP/2.0 487 Request Terminated
  1091. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1092. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1093. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1094. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1095. CSeq: 102 INVITE
  1096. Server: FPBX-12.0.76.4(13.14.0)
  1097. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1098. Supported: replaces, timer
  1099. Content-Length: 0
  1100.  
  1101.  
  1102. ---
  1103.  
  1104. <--- SIP read from UDP:10.1.212.13:51236 --->
  1105. BYE sip:1068@10.101.10.60:5060 SIP/2.0
  1106. Via: SIP/2.0/UDP 10.1.212.13:5060;branch=z9hG4bKea5710c1
  1107. From: <sip:1096@10.1.212.13:5060;transport=udp>;tag=081735144cdc003e20fd9f13-4fc5f748
  1108. To: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as67dd3ea1
  1109. Call-ID: 03469a3f6df446fc1d1126db040b0440@10.101.10.60:5060
  1110. Max-Forwards: 70
  1111. Date: Mon, 20 Feb 2017 19:50:04 GMT
  1112. CSeq: 101 BYE
  1113. User-Agent: Cisco-CP7945G/9.3.1
  1114. Content-Length: 0
  1115.  
  1116. <------------->
  1117. --- (10 headers 0 lines) ---
  1118. Sending to 10.1.212.13:5060 (no NAT)
  1119. Scheduling destruction of SIP dialog '03469a3f6df446fc1d1126db040b0440@10.101.10.60:5060' in 6400 ms (Method: BYE)
  1120.  
  1121. <--- Transmitting (no NAT) to 10.1.212.13:5060 --->
  1122. SIP/2.0 200 OK
  1123. Via: SIP/2.0/UDP 10.1.212.13:5060;branch=z9hG4bKea5710c1;received=10.1.212.13
  1124. From: <sip:1096@10.1.212.13:5060;transport=udp>;tag=081735144cdc003e20fd9f13-4fc5f748
  1125. To: "Jonathan Cox" <sip:1068@10.101.10.60>;tag=as67dd3ea1
  1126. Call-ID: 03469a3f6df446fc1d1126db040b0440@10.101.10.60:5060
  1127. CSeq: 101 BYE
  1128. Server: FPBX-12.0.76.4(13.14.0)
  1129. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1130. Supported: replaces, timer
  1131. Content-Length: 0
  1132.  
  1133.  
  1134. <------------>
  1135.     -- Stopped music on hold on SIP/1096-00000001
  1136.     -- Channel SIP/1096-00000001 left 'simple_bridge' basic-bridge <f22212bb-eca2-4689-95e2-11722cb18830>
  1137.     -- Channel SIP/1068-00000000 left 'simple_bridge' basic-bridge <f22212bb-eca2-4689-95e2-11722cb18830>
  1138.   == Spawn extension (macro-dial-one, s, 45) exited non-zero on 'SIP/1068-00000000' in macro 'dial-one'
  1139.   == Spawn extension (macro-exten-vm, s, 14) exited non-zero on 'SIP/1068-00000000' in macro 'exten-vm'
  1140.   == Spawn extension (from-internal, 1096, 2) exited non-zero on 'SIP/1068-00000000'
  1141.     -- Executing [h@from-internal:1] Hangup("SIP/1068-00000000", "") in new stack
  1142.   == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/1068-00000000'
  1143. Scheduling destruction of SIP dialog '0023eb53-0a6a0009-7968a141-8d5ad8ef@10.1.212.12' in 6400 ms (Method: ACK)
  1144. set_destination: Parsing <sip:1068@10.1.212.12:5060;transport=udp> for address/port to send to
  1145. set_destination: set destination to 10.1.212.12:5060
  1146. Reliably Transmitting (no NAT) to 10.1.212.12:5060:
  1147. BYE sip:1068@10.1.212.12:5060;transport=udp SIP/2.0
  1148. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK3fe86e26
  1149. Max-Forwards: 70
  1150. From: <sip:1096@10.101.10.60>;tag=as364b2038
  1151. To: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a0024bba57645-e73d585b
  1152. Call-ID: 0023eb53-0a6a0009-7968a141-8d5ad8ef@10.1.212.12
  1153. CSeq: 102 BYE
  1154. User-Agent: FPBX-12.0.76.4(13.14.0)
  1155. Proxy-Authorization: Digest username="1068", realm="asterisk", algorithm=MD5, uri="sip:10.101.10.60", nonce="67ecc3ac", response="3163c6c35a367572cf5ca663b974924f"
  1156. X-Asterisk-HangupCause: Normal Clearing
  1157. X-Asterisk-HangupCauseCode: 16
  1158. Content-Length: 0
  1159.  
  1160.  
  1161. ---
  1162. Retransmitting #3 (no NAT) to 10.1.212.12:5060:
  1163. SIP/2.0 487 Request Terminated
  1164. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1165. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1166. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1167. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1168. CSeq: 102 INVITE
  1169. Server: FPBX-12.0.76.4(13.14.0)
  1170. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1171. Supported: replaces, timer
  1172. Content-Length: 0
  1173.  
  1174.  
  1175. ---
  1176.  
  1177. <--- SIP read from UDP:10.1.212.12:51917 --->
  1178. SIP/2.0 200 OK
  1179. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK3fe86e26
  1180. From: <sip:1096@10.101.10.60>;tag=as364b2038
  1181. To: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a0024bba57645-e73d585b
  1182. Call-ID: 0023eb53-0a6a0009-7968a141-8d5ad8ef@10.1.212.12
  1183. Date: Mon, 20 Feb 2017 19:50:04 GMT
  1184. CSeq: 102 BYE
  1185. Server: Cisco-CP7965G/9.3.1
  1186. Content-Length: 0
  1187.  
  1188. <------------->
  1189. --- (9 headers 0 lines) ---
  1190. SIP Response message for INCOMING dialog BYE arrived
  1191. Really destroying SIP dialog '0023eb53-0a6a0009-7968a141-8d5ad8ef@10.1.212.12' Method: ACK
  1192. Retransmitting #4 (no NAT) to 10.1.212.12:5060:
  1193. SIP/2.0 487 Request Terminated
  1194. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1195. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1196. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1197. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1198. CSeq: 102 INVITE
  1199. Server: FPBX-12.0.76.4(13.14.0)
  1200. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1201. Supported: replaces, timer
  1202. Content-Length: 0
  1203.  
  1204.  
  1205. ---
  1206. Retransmitting #5 (no NAT) to 10.1.212.12:5060:
  1207. SIP/2.0 487 Request Terminated
  1208. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1209. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1210. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1211. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1212. CSeq: 102 INVITE
  1213. Server: FPBX-12.0.76.4(13.14.0)
  1214. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1215. Supported: replaces, timer
  1216. Content-Length: 0
  1217.  
  1218.  
  1219. ---
  1220. Reliably Transmitting (no NAT) to 10.40.1.83:62763:
  1221. OPTIONS sip:1398@10.40.1.83:62763;rinstance=cc8deec48838efb5;transport=UDP SIP/2.0
  1222. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK487d0f28
  1223. Max-Forwards: 70
  1224. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as010b17c6
  1225. To: <sip:1398@10.40.1.83:62763;rinstance=cc8deec48838efb5;transport=UDP>
  1226. Contact: <sip:Unknown@10.101.10.60:5060>
  1227. Call-ID: 31bfa3023fd78b1d33091f984c184362@10.101.10.60:5060
  1228. CSeq: 102 OPTIONS
  1229. User-Agent: FPBX-12.0.76.4(13.14.0)
  1230. Date: Mon, 20 Feb 2017 19:50:07 GMT
  1231. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1232. Supported: replaces, timer
  1233. Content-Length: 0
  1234.  
  1235.  
  1236. ---
  1237.  
  1238. <--- SIP read from UDP:10.40.1.83:62763 --->
  1239. SIP/2.0 200 OK
  1240. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK487d0f28
  1241. Contact: <sip:10.40.1.83:62763>
  1242. To: <sip:1398@10.40.1.83:62763;rinstance=cc8deec48838efb5;transport=UDP>;tag=f3290d31
  1243. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as010b17c6
  1244. Call-ID: 31bfa3023fd78b1d33091f984c184362@10.101.10.60:5060
  1245. CSeq: 102 OPTIONS
  1246. Accept: application/sdp, application/sdp
  1247. Accept-Language: en
  1248. Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
  1249. Supported: replaces, norefersub, extended-refer, timer, outbound, path, X-cisco-serviceuri
  1250. User-Agent: Z 3.9.32144 r32121
  1251. Allow-Events: presence, kpml
  1252. Content-Length: 0
  1253.  
  1254. <------------->
  1255. --- (14 headers 0 lines) ---
  1256. Really destroying SIP dialog '31bfa3023fd78b1d33091f984c184362@10.101.10.60:5060' Method: OPTIONS
  1257. Reliably Transmitting (no NAT) to 10.1.212.12:5060:
  1258. OPTIONS sip:1068@10.1.212.12:5060;transport=udp SIP/2.0
  1259. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK44c4dd55
  1260. Max-Forwards: 70
  1261. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as0f0a000b
  1262. To: <sip:1068@10.1.212.12:5060;transport=udp>
  1263. Contact: <sip:Unknown@10.101.10.60:5060>
  1264. Call-ID: 0ccf62e83812db6b0e9eeb7729398a55@10.101.10.60:5060
  1265. CSeq: 102 OPTIONS
  1266. User-Agent: FPBX-12.0.76.4(13.14.0)
  1267. Date: Mon, 20 Feb 2017 19:50:09 GMT
  1268. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1269. Supported: replaces, timer
  1270. Content-Length: 0
  1271.  
  1272.  
  1273. ---
  1274.  
  1275. <--- SIP read from UDP:10.1.212.12:51304 --->
  1276. SIP/2.0 200 OK
  1277. Via: SIP/2.0/UDP 10.101.10.60:5060;branch=z9hG4bK44c4dd55
  1278. From: "Unknown" <sip:Unknown@10.101.10.60>;tag=as0f0a000b
  1279. To: <sip:1068@10.1.212.12:5060;transport=udp>;tag=0023eb530a6a002859db4cae-b212ae3f
  1280. Call-ID: 0ccf62e83812db6b0e9eeb7729398a55@10.101.10.60:5060
  1281. Date: Mon, 20 Feb 2017 19:50:09 GMT
  1282. CSeq: 102 OPTIONS
  1283. Server: Cisco-CP7965G/9.3.1
  1284. Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE
  1285. Allow-Events: kpml,dialog,refer
  1286. Accept: application/sdp,multipart/mixed,multipart/alternative
  1287. Accept-Encoding: identity
  1288. Accept-Language: en
  1289. Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.0
  1290. Content-Length: 312
  1291. Content-Type: application/sdp
  1292. Content-Disposition: session;handling=optional
  1293.  
  1294. v=0
  1295. o=Cisco-SIPUA 16438 0 IN IP4 10.1.212.12
  1296. s=SIP Call
  1297. t=0 0
  1298. m=audio 0 RTP/AVP 8 0 18 102 116 101
  1299. a=rtpmap:8 PCMA/8000
  1300. a=rtpmap:0 PCMU/8000
  1301. a=rtpmap:18 G729/8000
  1302. a=fmtp:18 annexb=no
  1303. a=rtpmap:102 L16/16000
  1304. a=rtpmap:116 iLBC/8000
  1305. a=fmtp:116 mode=20
  1306. a=rtpmap:101 telephone-event/8000
  1307. a=fmtp:101 0-15
  1308. <------------->
  1309. --- (17 headers 14 lines) ---
  1310. Really destroying SIP dialog '0ccf62e83812db6b0e9eeb7729398a55@10.101.10.60:5060' Method: OPTIONS
  1311. Retransmitting #6 (no NAT) to 10.1.212.12:5060:
  1312. SIP/2.0 487 Request Terminated
  1313. Via: SIP/2.0/UDP 10.1.212.12:5060;branch=z9hG4bKce5a92dc;received=10.1.212.12
  1314. From: "1068" <sip:1068@10.101.10.60>;tag=0023eb530a6a00262bd91ae0-4be7b65d
  1315. To: <sip:8985@10.101.10.60>;tag=as7a14e517
  1316. Call-ID: 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12
  1317. CSeq: 102 INVITE
  1318. Server: FPBX-12.0.76.4(13.14.0)
  1319. Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  1320. Supported: replaces, timer
  1321. Content-Length: 0
  1322.  
  1323.  
  1324. ---
  1325. [2017-02-20 14:50:10] WARNING[24474]: chan_sip.c:4059 retrans_pkt: Retransmission timeout reached on transmission 0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12 for seqno 102 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
  1326. Packet timed out after 6400ms with no response
  1327. Really destroying SIP dialog '0023eb53-0a6a000b-cb13fa4e-bcafc26f@10.1.212.12' Method: CANCEL
  1328. Really destroying SIP dialog '1d9b30185b4780aa3d97ea9c02d1a5a8@10.101.10.60:5060' Method: INVITE
  1329. Really destroying SIP dialog '03469a3f6df446fc1d1126db040b0440@10.101.10.60:5060' Method: BYE
  1330.  
  1331. <--- SIP read from UDP:10.1.20.190:5060 --->
  1332.  
  1333. <------------->
  1334. ghwhqpbxbu01*CLI> sip set debug off
  1335. SIP Debugging Disabled
  1336.     -- Attempting call on Local/s@tc-maint for application NoCDR() (Retry 1)
  1337.     -- Called s@tc-maint
  1338.     -- Executing [s@tc-maint:1] NoCDR("Local/s@tc-maint-00000003;2", "") in new stack
  1339.     -- Executing [s@tc-maint:2] Set("Local/s@tc-maint-00000003;2", "TCMAINT=RETURN") in new stack
  1340.     -- Executing [s@tc-maint:3] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,1,1()") in new stack
  1341.     -- Executing [1@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/1/INUSESTATE)=INUSE") in new stack
  1342.     -- Executing [1@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1343.     -- Executing [1@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "18:00-09:00,mon-fri,1-31,jan-dec,America/New_York?truestate") in new stack
  1344.     -- Executing [1@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1345.     -- Executing [1@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/1)=)") in new stack
  1346.     -- Executing [1@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
  1347.     -- Executing [1@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1348.     -- Executing [1@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,3,1") in new stack
  1349.     -- Executing [1@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1350.     -- Executing [1@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1351.     -- Executing [1@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1352.     -- Executing [s@tc-maint:4] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,10,1()") in new stack
  1353.     -- Executing [10@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/10/INUSESTATE)=INUSE") in new stack
  1354.     -- Executing [10@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/10/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1355.     -- Executing [10@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,4,jul?truestate") in new stack
  1356.     -- Executing [10@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1357.     -- Executing [10@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/10)=)") in new stack
  1358.     -- Executing [10@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC10)=INUSE") in new stack
  1359.     -- Executing [10@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1360.     -- Executing [10@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?app-blackhole,hangup,1") in new stack
  1361.     -- Executing [10@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1362.     -- Executing [10@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1363.     -- Executing [10@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1364.     -- Executing [s@tc-maint:5] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,9,1()") in new stack
  1365.     -- Executing [9@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/9/INUSESTATE)=INUSE") in new stack
  1366.     -- Executing [9@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/9/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1367.     -- Executing [9@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,24-25,nov,America/New_York?truestate") in new stack
  1368.     -- Executing [9@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1369.     -- Executing [9@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/9)=)") in new stack
  1370.     -- Executing [9@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC9)=INUSE") in new stack
  1371.     -- Executing [9@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1372.     -- Executing [9@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?app-blackhole,hangup,1") in new stack
  1373.     -- Executing [9@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1374.     -- Executing [9@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1375.     -- Executing [9@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1376.     -- Executing [s@tc-maint:6] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,8,1()") in new stack
  1377.     -- Executing [8@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/8/INUSESTATE)=INUSE") in new stack
  1378.     -- Executing [8@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/8/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1379.     -- Executing [8@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,23-26,dec,America/New_York?truestate") in new stack
  1380.     -- Executing [8@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1381.     -- Executing [8@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/8)=)") in new stack
  1382.     -- Executing [8@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC8)=INUSE") in new stack
  1383.     -- Executing [8@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1384.     -- Executing [8@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,9,1") in new stack
  1385.     -- Executing [8@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1386.     -- Executing [8@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1387.     -- Executing [8@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1388.     -- Executing [s@tc-maint:7] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,7,1()") in new stack
  1389.     -- Executing [7@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/7/INUSESTATE)=INUSE") in new stack
  1390.     -- Executing [7@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/7/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1391.     -- Executing [7@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,wed,17,aug?truestate") in new stack
  1392.     -- Executing [7@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1393.     -- Executing [7@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/7)=)") in new stack
  1394.     -- Executing [7@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC7)=INUSE") in new stack
  1395.     -- Executing [7@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1396.     -- Executing [7@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?ext-group,4682,1") in new stack
  1397.     -- Executing [7@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1398.     -- Executing [7@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1399.     -- Executing [7@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1400.     -- Executing [s@tc-maint:8] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,6,1()") in new stack
  1401.     -- Executing [6@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/6/INUSESTATE)=INUSE") in new stack
  1402.     -- Executing [6@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/6/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1403.     -- Executing [6@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,sat-sun,*,jan-dec,America/New_York?truestate") in new stack
  1404.     -- Executing [6@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1405.     -- Executing [6@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/6)=)") in new stack
  1406.     -- Executing [6@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC6)=INUSE") in new stack
  1407.     -- Executing [6@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1408.     -- Executing [6@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?directory,1,1") in new stack
  1409.     -- Executing [6@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1410.     -- Executing [6@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1411.     -- Executing [6@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1412.     -- Executing [s@tc-maint:9] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,5,1()") in new stack
  1413.     -- Executing [5@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/5/INUSESTATE)=INUSE") in new stack
  1414.     -- Executing [5@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/5/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1415.     -- Executing [5@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,24-25,nov?truestate") in new stack
  1416.     -- Executing [5@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1417.     -- Executing [5@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/5)=)") in new stack
  1418.     -- Executing [5@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC5)=INUSE") in new stack
  1419.     -- Executing [5@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1420.     -- Executing [5@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,6,1") in new stack
  1421.     -- Executing [5@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1422.     -- Executing [5@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1423.     -- Executing [5@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1424.     -- Executing [s@tc-maint:10] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,4,1()") in new stack
  1425.     -- Executing [4@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/4/INUSESTATE)=INUSE") in new stack
  1426.     -- Executing [4@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/4/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1427.     -- Executing [4@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,4,jul,America/New_York?truestate") in new stack
  1428.     -- Executing [4@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1429.     -- Executing [4@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/4)=)") in new stack
  1430.     -- Executing [4@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC4)=INUSE") in new stack
  1431.     -- Executing [4@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1432.     -- Executing [4@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,5,1") in new stack
  1433.     -- Executing [4@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1434.     -- Executing [4@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1435.     -- Executing [4@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1436.     -- Executing [s@tc-maint:11] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,3,1()") in new stack
  1437.     -- Executing [3@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/3/INUSESTATE)=INUSE") in new stack
  1438.     -- Executing [3@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/3/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1439.     -- Executing [3@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,30-2,dec-jan,America/New_York?truestate") in new stack
  1440.     -- Executing [3@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1441.     -- Executing [3@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/3)=)") in new stack
  1442.     -- Executing [3@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC3)=INUSE") in new stack
  1443.     -- Executing [3@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1444.     -- Executing [3@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,2,1") in new stack
  1445.     -- Executing [3@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1446.     -- Executing [3@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1447.     -- Executing [3@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1448.     -- Executing [s@tc-maint:12] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,2,1()") in new stack
  1449.     -- Executing [2@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/2/INUSESTATE)=INUSE") in new stack
  1450.     -- Executing [2@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/2/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1451.     -- Executing [2@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,23-26,dec?truestate") in new stack
  1452.     -- Executing [2@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1453.     -- Executing [2@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/2)=)") in new stack
  1454.     -- Executing [2@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC2)=INUSE") in new stack
  1455.     -- Executing [2@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1456.     -- Executing [2@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,4,1") in new stack
  1457.     -- Executing [2@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1458.     -- Executing [2@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1459.     -- Executing [2@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1460.     -- Executing [s@tc-maint:13] Gosub("Local/s@tc-maint-00000003;2", "timeconditions,11,1()") in new stack
  1461.     -- Executing [11@timeconditions:1] Set("Local/s@tc-maint-00000003;2", "DB(TC/11/INUSESTATE)=INUSE") in new stack
  1462.     -- Executing [11@timeconditions:2] Set("Local/s@tc-maint-00000003;2", "DB(TC/11/NOT_INUSESTATE)=NOT_INUSE") in new stack
  1463.     -- Executing [11@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000003;2", "00:00-23:59,*,30-2,dec-jan?truestate") in new stack
  1464.     -- Executing [11@timeconditions:4] GotoIf("Local/s@tc-maint-00000003;2", "0?truegoto") in new stack
  1465.     -- Executing [11@timeconditions:5] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(DB(TC/11)=)") in new stack
  1466.     -- Executing [11@timeconditions:6] Set("Local/s@tc-maint-00000003;2", "DEVICE_STATE(Custom:TC11)=INUSE") in new stack
  1467.     -- Executing [11@timeconditions:7] ExecIf("Local/s@tc-maint-00000003;2", "0?Set(NOT_INUSE)") in new stack
  1468.     -- Executing [11@timeconditions:8] GotoIf("Local/s@tc-maint-00000003;2", "0?timeconditions,1,1") in new stack
  1469.     -- Executing [11@timeconditions:9] Set("Local/s@tc-maint-00000003;2", "TCSTATE=false") in new stack
  1470.     -- Executing [11@timeconditions:10] Set("Local/s@tc-maint-00000003;2", "TCOVERRIDE=false") in new stack
  1471.     -- Executing [11@timeconditions:11] Return("Local/s@tc-maint-00000003;2", "") in new stack
  1472.     -- Executing [s@tc-maint:14] System("Local/s@tc-maint-00000003;2", "/var/lib/asterisk/bin/schedtc.php 60 /var/spool/asterisk/outgoing 0") in new stack
  1473.     -- Executing [s@tc-maint:15] Answer("Local/s@tc-maint-00000003;2", "") in new stack
  1474.     -- Local/s@tc-maint-00000003;1 answered
  1475.   == Spawn extension (tc-maint, s, 15) exited non-zero on 'Local/s@tc-maint-00000003;2'
  1476. [2017-02-20 14:51:00] NOTICE[24576]: pbx_spool.c:426 attempt_thread: Call comple

Reply to "Re: Cisco 7945 unable to join two calls together"

Here you can reply to the paste above