call

From kermit, 2 Months ago, written in Plain Text, viewed 14 times.
URL http://pastebin.freepbx.org/view/861ed749 Embed
Download Paste or View Raw
  1. [2017-11-08 10:34:15] DEBUG[2184]: devicestate.c:474 do_state_change: Changing state for IAX2/222 - state 3 (Busy)
  2. Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 005 Type: IAX     Subclass: ACK
  3.    Timestamp: 04223ms  SCall: 00059  DCall: 12378 192.168.10.53:4569
  4. [2017-11-08 10:34:15] DEBUG[2317]: chan_iax2.c:10379 socket_process_helper: Received packet 3, (6, 4)
  5. [2017-11-08 10:34:15] DEBUG[2317]: chan_iax2.c:10476 socket_process_helper: Cancelling transmission of packet 4
  6. [2017-11-08 10:34:15] DEBUG[2317]: chan_iax2.c:10650 socket_process_helper: IAX subclass 4 received
  7. [2017-11-08 10:34:15] DEBUG[2346]: app_queue.c:2491 device_state_cb: Device 'IAX2/222' changed to state '3' (Busy) but we don't care because they're not a member of any queue.
  8. [2017-11-08 10:34:15] DEBUG[2211]: devicestate.c:365 _ast_device_state: Checking if I can find provider for "Custom" - number: DND222
  9. [2017-11-08 10:34:15] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider SLA with Custom
  10. [2017-11-08 10:34:15] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  11. Event: DeviceStateChange
  12. Privilege: call,all
  13. Device: IAX2/222
  14. State: BUSY
  15.  
  16.  
  17. [2017-11-08 10:34:15] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider Meetme with Custom
  18. [2017-11-08 10:34:15] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider Custom with Custom
  19. [2017-11-08 10:34:15] DEBUG[2211]: db.c:376 db_get_common: Unable to find key 'DND222' in family 'CustomDevstate'
  20. [2017-11-08 10:34:15] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  21. Event: DeviceStateChange
  22. Privilege: call,all
  23. Device: IAX2/222
  24. State: BUSY
  25.  
  26.  
  27. [2017-11-08 10:34:15] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  28. Event: ExtensionStatus
  29. Privilege: call,all
  30. Exten: 222
  31. Context: ext-local
  32. Hint: IAX2/222&Custom:DND222,CustomPresence:222
  33. Status: 2
  34. StatusText: Busy
  35.  
  36.  
  37. [2017-11-08 10:34:15] DEBUG[2211]: app_queue.c:2566 extension_state_cb: Extension '222@ext-local' changed to state '3' (Busy) but we don't care because they're not a member of any queue.
  38. [2017-11-08 10:34:15] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  39. Event: ExtensionStatus
  40. Privilege: call,all
  41. Exten: 222
  42. Context: ext-local
  43. Hint: IAX2/222&Custom:DND222,CustomPresence:222
  44. Status: 2
  45. StatusText: Busy
  46.  
  47.  
  48. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: channel.c:3469 ast_settimeout_full: Scheduling timer at (50 requested / 50 actual) timer ticks per second
  49. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: channel.c:4977 ast_prod: Prodding channel 'IAX2/222-12378'
  50. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: channel.c:8107 ast_channel_start_silence_generator: Started silence generator on 'IAX2/222-12378'
  51. [2017-11-08 10:34:15] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4247
  52. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4240 on 12378/59 to 192.168.10.53:4569
  53. [2017-11-08 10:34:15] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4267
  54. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4260 on 12378/59 to 192.168.10.53:4569
  55. [2017-11-08 10:34:15] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4287
  56. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4280 on 12378/59 to 192.168.10.53:4569
  57. [2017-11-08 10:34:15] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4307
  58. [2017-11-08 10:34:15] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4300 on 12378/59 to 192.168.10.53:4569
  59. [2017-11-08 10:34:15] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4327
  60. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4320 on 12378/59 to 192.168.10.53:4569
  61. [2017-11-08 10:34:16] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4347
  62. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4340 on 12378/59 to 192.168.10.53:4569
  63. [2017-11-08 10:34:16] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4367
  64. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4360 on 12378/59 to 192.168.10.53:4569
  65. [2017-11-08 10:34:16] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4387
  66. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4380 on 12378/59 to 192.168.10.53:4569
  67. [2017-11-08 10:34:16] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4407
  68. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4400 on 12378/59 to 192.168.10.53:4569
  69. [2017-11-08 10:34:16] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4427
  70. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4420 on 12378/59 to 192.168.10.53:4569
  71. [2017-11-08 10:34:16] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4447
  72. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4440 on 12378/59 to 192.168.10.53:4569
  73. [2017-11-08 10:34:16] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4467
  74. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4460 on 12378/59 to 192.168.10.53:4569
  75. [2017-11-08 10:34:16] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4487
  76. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4480 on 12378/59 to 192.168.10.53:4569
  77. [2017-11-08 10:34:16] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4507
  78. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4500 on 12378/59 to 192.168.10.53:4569
  79. [2017-11-08 10:34:16] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4527
  80. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4520 on 12378/59 to 192.168.10.53:4569
  81. [2017-11-08 10:34:16] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4547
  82. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4540 on 12378/59 to 192.168.10.53:4569
  83. [2017-11-08 10:34:16] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4567
  84. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4560 on 12378/59 to 192.168.10.53:4569
  85. [2017-11-08 10:34:16] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4587
  86. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4580 on 12378/59 to 192.168.10.53:4569
  87. [2017-11-08 10:34:16] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4607
  88. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4600 on 12378/59 to 192.168.10.53:4569
  89. [2017-11-08 10:34:16] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4627
  90. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4620 on 12378/59 to 192.168.10.53:4569
  91. [2017-11-08 10:34:16] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4647
  92. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4640 on 12378/59 to 192.168.10.53:4569
  93. [2017-11-08 10:34:16] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4667
  94. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4660 on 12378/59 to 192.168.10.53:4569
  95. [2017-11-08 10:34:16] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4687
  96. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4680 on 12378/59 to 192.168.10.53:4569
  97. [2017-11-08 10:34:16] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4707
  98. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4700 on 12378/59 to 192.168.10.53:4569
  99. [2017-11-08 10:34:16] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4727
  100. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4720 on 12378/59 to 192.168.10.53:4569
  101. [2017-11-08 10:34:16] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4747
  102. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4740 on 12378/59 to 192.168.10.53:4569
  103. [2017-11-08 10:34:16] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4767
  104. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4760 on 12378/59 to 192.168.10.53:4569
  105. [2017-11-08 10:34:16] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4787
  106. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4780 on 12378/59 to 192.168.10.53:4569
  107. [2017-11-08 10:34:16] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4807
  108. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4800 on 12378/59 to 192.168.10.53:4569
  109. [2017-11-08 10:34:16] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4827
  110. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4820 on 12378/59 to 192.168.10.53:4569
  111. [2017-11-08 10:34:16] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4847
  112. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4840 on 12378/59 to 192.168.10.53:4569
  113. [2017-11-08 10:34:16] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4867
  114. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4860 on 12378/59 to 192.168.10.53:4569
  115. [2017-11-08 10:34:16] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4887
  116. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4880 on 12378/59 to 192.168.10.53:4569
  117. [2017-11-08 10:34:16] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4907
  118. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4900 on 12378/59 to 192.168.10.53:4569
  119. [2017-11-08 10:34:16] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4927
  120. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4920 on 12378/59 to 192.168.10.53:4569
  121. [2017-11-08 10:34:16] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4947
  122. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4940 on 12378/59 to 192.168.10.53:4569
  123. [2017-11-08 10:34:16] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4967
  124. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4960 on 12378/59 to 192.168.10.53:4569
  125. [2017-11-08 10:34:16] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=4987
  126. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 4980 on 12378/59 to 192.168.10.53:4569
  127. [2017-11-08 10:34:16] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5007
  128. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5000 on 12378/59 to 192.168.10.53:4569
  129. [2017-11-08 10:34:16] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5027
  130. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5020 on 12378/59 to 192.168.10.53:4569
  131. [2017-11-08 10:34:16] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5047
  132. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5040 on 12378/59 to 192.168.10.53:4569
  133. [2017-11-08 10:34:16] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5067
  134. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5060 on 12378/59 to 192.168.10.53:4569
  135. [2017-11-08 10:34:16] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5087
  136. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5080 on 12378/59 to 192.168.10.53:4569
  137. [2017-11-08 10:34:16] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5107
  138. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5100 on 12378/59 to 192.168.10.53:4569
  139. [2017-11-08 10:34:16] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5127
  140. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5120 on 12378/59 to 192.168.10.53:4569
  141. [2017-11-08 10:34:16] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5147
  142. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5140 on 12378/59 to 192.168.10.53:4569
  143. [2017-11-08 10:34:16] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5167
  144. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5160 on 12378/59 to 192.168.10.53:4569
  145. [2017-11-08 10:34:16] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5187
  146. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5180 on 12378/59 to 192.168.10.53:4569
  147. [2017-11-08 10:34:16] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5207
  148. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5200 on 12378/59 to 192.168.10.53:4569
  149. [2017-11-08 10:34:16] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5227
  150. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5220 on 12378/59 to 192.168.10.53:4569
  151. [2017-11-08 10:34:16] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5247
  152. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5240 on 12378/59 to 192.168.10.53:4569
  153. [2017-11-08 10:34:16] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5267
  154. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5260 on 12378/59 to 192.168.10.53:4569
  155. [2017-11-08 10:34:16] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5287
  156. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5280 on 12378/59 to 192.168.10.53:4569
  157. [2017-11-08 10:34:16] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5307
  158. [2017-11-08 10:34:16] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5300 on 12378/59 to 192.168.10.53:4569
  159. [2017-11-08 10:34:16] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5327
  160. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5320 on 12378/59 to 192.168.10.53:4569
  161. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5347
  162. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5340 on 12378/59 to 192.168.10.53:4569
  163. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5367
  164. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5360 on 12378/59 to 192.168.10.53:4569
  165. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5387
  166. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5380 on 12378/59 to 192.168.10.53:4569
  167. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5407
  168. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5400 on 12378/59 to 192.168.10.53:4569
  169. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5427
  170. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5420 on 12378/59 to 192.168.10.53:4569
  171. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5447
  172. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5440 on 12378/59 to 192.168.10.53:4569
  173. [2017-11-08 10:34:17] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5467
  174. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5460 on 12378/59 to 192.168.10.53:4569
  175. [2017-11-08 10:34:17] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5487
  176. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5480 on 12378/59 to 192.168.10.53:4569
  177. [2017-11-08 10:34:17] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5507
  178. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5500 on 12378/59 to 192.168.10.53:4569
  179. [2017-11-08 10:34:17] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5527
  180. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5520 on 12378/59 to 192.168.10.53:4569
  181. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5547
  182. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5540 on 12378/59 to 192.168.10.53:4569
  183. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5567
  184. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5560 on 12378/59 to 192.168.10.53:4569
  185. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5587
  186. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5580 on 12378/59 to 192.168.10.53:4569
  187. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5607
  188. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5600 on 12378/59 to 192.168.10.53:4569
  189. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5627
  190. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5620 on 12378/59 to 192.168.10.53:4569
  191. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5647
  192. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5640 on 12378/59 to 192.168.10.53:4569
  193. [2017-11-08 10:34:17] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5667
  194. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5660 on 12378/59 to 192.168.10.53:4569
  195. [2017-11-08 10:34:17] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5687
  196. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5680 on 12378/59 to 192.168.10.53:4569
  197. [2017-11-08 10:34:17] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5707
  198. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5700 on 12378/59 to 192.168.10.53:4569
  199. [2017-11-08 10:34:17] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5727
  200. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5720 on 12378/59 to 192.168.10.53:4569
  201. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:12145 iax2_do_register: Sending registration request for '214364_FPBX'
  202. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:12178 iax2_do_register: Allocate call number
  203. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:2683 peercnt_add: ip callno count incremented to 2 for 173.248.161.90
  204. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:3220 __find_callno: Creating new call structure 256
  205. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:12185 iax2_do_register: Registration created on call 256
  206. [2017-11-08 10:34:17] DEBUG[2314]: chan_iax2.c:3432 send_packet: Sending 12 on 256/0 to 173.248.161.90:4569
  207. Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX     Subclass: REGREQ
  208.    Timestamp: 00012ms  SCall: 00256  DCall: 00000 173.248.161.90:4569
  209.    USERNAME        : 214364_FPBX
  210.    REFRESH         : 60
  211.  
  212. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5747
  213. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5740 on 12378/59 to 192.168.10.53:4569
  214. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5767
  215. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5760 on 12378/59 to 192.168.10.53:4569
  216. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5787
  217. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5780 on 12378/59 to 192.168.10.53:4569
  218. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5807
  219. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5800 on 12378/59 to 192.168.10.53:4569
  220. Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: CTOKEN
  221.    Timestamp: 00012ms  SCall: 00001  DCall: 00256 173.248.161.90:4569
  222.    CALLTOKEN       : 51 bytes
  223.  
  224. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10379 socket_process_helper: Received packet 0, (6, 40)
  225. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10476 socket_process_helper: Cancelling transmission of packet 0
  226. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10650 socket_process_helper: IAX subclass 40 received
  227. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10659 socket_process_helper: For call=256, set last=12
  228. [2017-11-08 10:34:17] DEBUG[2314]: chan_iax2.c:3432 send_packet: Sending 92 on 256/0 to 173.248.161.90:4569
  229. Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX     Subclass: REGREQ
  230.    Timestamp: 00092ms  SCall: 00256  DCall: 00000 173.248.161.90:4569
  231.    USERNAME        : 214364_FPBX
  232.    REFRESH         : 60
  233.    CALLTOKEN       : 51 bytes
  234.  
  235. [2017-11-08 10:34:17] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5827
  236. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5820 on 12378/59 to 192.168.10.53:4569
  237. [2017-11-08 10:34:17] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5847
  238. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5840 on 12378/59 to 192.168.10.53:4569
  239. [2017-11-08 10:34:17] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5867
  240. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5860 on 12378/59 to 192.168.10.53:4569
  241. [2017-11-08 10:34:17] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5887
  242. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5880 on 12378/59 to 192.168.10.53:4569
  243. Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: REGAUTH
  244.    Timestamp: 00005ms  SCall: 15124  DCall: 00256 173.248.161.90:4569
  245.    AUTHMETHODS     : 3
  246.    CHALLENGE       : \x35\x35\x39\x37\x31\x38\x34\x38\x37
  247.    USERNAME        : 214364_FPBX
  248.  
  249. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:10379 socket_process_helper: Received packet 0, (6, 14)
  250. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:10476 socket_process_helper: Cancelling transmission of packet 0
  251. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:10650 socket_process_helper: IAX subclass 14 received
  252. [2017-11-08 10:34:17] DEBUG[2314]: chan_iax2.c:3432 send_packet: Sending 173 on 256/15124 to 173.248.161.90:4569
  253. Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX     Subclass: REGREQ
  254.    Timestamp: 00173ms  SCall: 00256  DCall: 15124 173.248.161.90:4569
  255.    USERNAME        : 214364_FPBX
  256.    REFRESH         : 60
  257.    MD5 RESULT      : ce73fc91038f07ed07403fe7714916e2
  258.  
  259. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5907
  260. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5900 on 12378/59 to 192.168.10.53:4569
  261. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5927
  262. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5920 on 12378/59 to 192.168.10.53:4569
  263. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5947
  264. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5940 on 12378/59 to 192.168.10.53:4569
  265. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5967
  266. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5960 on 12378/59 to 192.168.10.53:4569
  267. Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: REGACK
  268.    Timestamp: 00086ms  SCall: 15124  DCall: 00256 173.248.161.90:4569
  269.    USERNAME        : 214364_FPBX
  270.    DATE TIME       : 2017-11-08  11:34:16
  271.    REFRESH         : 60
  272.    APPARENT ADDRES : IPV4 187.136.201.9:40562
  273.    CALLING NUMBER  :
  274.  
  275. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10379 socket_process_helper: Received packet 1, (6, 15)
  276. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10476 socket_process_helper: Cancelling transmission of packet 1
  277. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10650 socket_process_helper: IAX subclass 15 received
  278. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:10659 socket_process_helper: For call=256, set last=86
  279. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:3432 send_packet: Sending 86 on 256/15124 to 173.248.161.90:4569
  280. Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX     Subclass: ACK
  281.    Timestamp: 00086ms  SCall: 00256  DCall: 15124 173.248.161.90:4569
  282. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:3083 sched_delay_remove: schedule decrement of callno used for 173.248.161.90 in 60 seconds
  283. [2017-11-08 10:34:17] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=5987
  284. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 5980 on 12378/59 to 192.168.10.53:4569
  285. [2017-11-08 10:34:17] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6007
  286. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6000 on 12378/59 to 192.168.10.53:4569
  287. [2017-11-08 10:34:17] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6027
  288. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6020 on 12378/59 to 192.168.10.53:4569
  289. [2017-11-08 10:34:17] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6047
  290. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6040 on 12378/59 to 192.168.10.53:4569
  291. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6067
  292. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6060 on 12378/59 to 192.168.10.53:4569
  293. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6087
  294. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6080 on 12378/59 to 192.168.10.53:4569
  295. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6107
  296. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6100 on 12378/59 to 192.168.10.53:4569
  297. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6127
  298. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6120 on 12378/59 to 192.168.10.53:4569
  299. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6147
  300. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6140 on 12378/59 to 192.168.10.53:4569
  301. [2017-11-08 10:34:17] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6167
  302. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6160 on 12378/59 to 192.168.10.53:4569
  303. [2017-11-08 10:34:17] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6187
  304. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6180 on 12378/59 to 192.168.10.53:4569
  305. [2017-11-08 10:34:17] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6207
  306. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6200 on 12378/59 to 192.168.10.53:4569
  307. [2017-11-08 10:34:17] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6227
  308. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6220 on 12378/59 to 192.168.10.53:4569
  309. [2017-11-08 10:34:17] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6247
  310. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6240 on 12378/59 to 192.168.10.53:4569
  311. [2017-11-08 10:34:17] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6267
  312. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6260 on 12378/59 to 192.168.10.53:4569
  313. [2017-11-08 10:34:17] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6287
  314. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6280 on 12378/59 to 192.168.10.53:4569
  315. [2017-11-08 10:34:17] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6307
  316. [2017-11-08 10:34:17] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6300 on 12378/59 to 192.168.10.53:4569
  317. [2017-11-08 10:34:17] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6327
  318. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6320 on 12378/59 to 192.168.10.53:4569
  319. [2017-11-08 10:34:18] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6347
  320. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6340 on 12378/59 to 192.168.10.53:4569
  321. [2017-11-08 10:34:18] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6367
  322. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6360 on 12378/59 to 192.168.10.53:4569
  323. [2017-11-08 10:34:18] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6387
  324. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6380 on 12378/59 to 192.168.10.53:4569
  325. [2017-11-08 10:34:18] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6407
  326. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6400 on 12378/59 to 192.168.10.53:4569
  327. [2017-11-08 10:34:18] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6427
  328. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6420 on 12378/59 to 192.168.10.53:4569
  329. [2017-11-08 10:34:18] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6447
  330. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6440 on 12378/59 to 192.168.10.53:4569
  331. [2017-11-08 10:34:18] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6467
  332. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6460 on 12378/59 to 192.168.10.53:4569
  333. [2017-11-08 10:34:18] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6487
  334. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6480 on 12378/59 to 192.168.10.53:4569
  335. [2017-11-08 10:34:18] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6507
  336. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6500 on 12378/59 to 192.168.10.53:4569
  337. [2017-11-08 10:34:18] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6527
  338. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6520 on 12378/59 to 192.168.10.53:4569
  339. [2017-11-08 10:34:18] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6547
  340. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6540 on 12378/59 to 192.168.10.53:4569
  341. [2017-11-08 10:34:18] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6567
  342. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6560 on 12378/59 to 192.168.10.53:4569
  343. [2017-11-08 10:34:18] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6587
  344. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6580 on 12378/59 to 192.168.10.53:4569
  345. [2017-11-08 10:34:18] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6607
  346. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6600 on 12378/59 to 192.168.10.53:4569
  347. [2017-11-08 10:34:18] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6627
  348. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6620 on 12378/59 to 192.168.10.53:4569
  349. [2017-11-08 10:34:18] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6647
  350. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6640 on 12378/59 to 192.168.10.53:4569
  351. [2017-11-08 10:34:18] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6667
  352. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6660 on 12378/59 to 192.168.10.53:4569
  353. [2017-11-08 10:34:18] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6687
  354. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6680 on 12378/59 to 192.168.10.53:4569
  355. [2017-11-08 10:34:18] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6707
  356. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6700 on 12378/59 to 192.168.10.53:4569
  357. [2017-11-08 10:34:18] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6727
  358. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6720 on 12378/59 to 192.168.10.53:4569
  359. [2017-11-08 10:34:18] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6747
  360. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6740 on 12378/59 to 192.168.10.53:4569
  361. [2017-11-08 10:34:18] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6767
  362. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6760 on 12378/59 to 192.168.10.53:4569
  363. [2017-11-08 10:34:18] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6787
  364. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6780 on 12378/59 to 192.168.10.53:4569
  365. [2017-11-08 10:34:18] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6807
  366. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6800 on 12378/59 to 192.168.10.53:4569
  367. [2017-11-08 10:34:18] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6827
  368. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6820 on 12378/59 to 192.168.10.53:4569
  369. [2017-11-08 10:34:18] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6847
  370. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6840 on 12378/59 to 192.168.10.53:4569
  371. [2017-11-08 10:34:18] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6867
  372. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6860 on 12378/59 to 192.168.10.53:4569
  373. [2017-11-08 10:34:18] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6887
  374. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6880 on 12378/59 to 192.168.10.53:4569
  375. [2017-11-08 10:34:18] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6907
  376. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6900 on 12378/59 to 192.168.10.53:4569
  377. [2017-11-08 10:34:18] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6927
  378. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6920 on 12378/59 to 192.168.10.53:4569
  379. [2017-11-08 10:34:18] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6947
  380. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6940 on 12378/59 to 192.168.10.53:4569
  381. [2017-11-08 10:34:18] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6967
  382. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6960 on 12378/59 to 192.168.10.53:4569
  383. [2017-11-08 10:34:18] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=6987
  384. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 6980 on 12378/59 to 192.168.10.53:4569
  385. [2017-11-08 10:34:18] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7007
  386. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7000 on 12378/59 to 192.168.10.53:4569
  387. [2017-11-08 10:34:18] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7027
  388. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7020 on 12378/59 to 192.168.10.53:4569
  389. [2017-11-08 10:34:18] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7047
  390. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7040 on 12378/59 to 192.168.10.53:4569
  391. [2017-11-08 10:34:18] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7067
  392. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7060 on 12378/59 to 192.168.10.53:4569
  393. [2017-11-08 10:34:18] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7087
  394. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7080 on 12378/59 to 192.168.10.53:4569
  395. [2017-11-08 10:34:18] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7107
  396. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7100 on 12378/59 to 192.168.10.53:4569
  397. [2017-11-08 10:34:18] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7127
  398. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7120 on 12378/59 to 192.168.10.53:4569
  399. [2017-11-08 10:34:18] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7147
  400. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7140 on 12378/59 to 192.168.10.53:4569
  401. [2017-11-08 10:34:18] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7167
  402. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7160 on 12378/59 to 192.168.10.53:4569
  403. [2017-11-08 10:34:18] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7187
  404. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7180 on 12378/59 to 192.168.10.53:4569
  405. [2017-11-08 10:34:18] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7207
  406. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7200 on 12378/59 to 192.168.10.53:4569
  407. [2017-11-08 10:34:18] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7227
  408. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7220 on 12378/59 to 192.168.10.53:4569
  409. [2017-11-08 10:34:18] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7247
  410. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7240 on 12378/59 to 192.168.10.53:4569
  411. [2017-11-08 10:34:18] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7267
  412. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7260 on 12378/59 to 192.168.10.53:4569
  413. [2017-11-08 10:34:18] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7287
  414. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7280 on 12378/59 to 192.168.10.53:4569
  415. [2017-11-08 10:34:18] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7307
  416. [2017-11-08 10:34:18] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7300 on 12378/59 to 192.168.10.53:4569
  417. [2017-11-08 10:34:19] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7327
  418. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7320 on 12378/59 to 192.168.10.53:4569
  419. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7347
  420. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7340 on 12378/59 to 192.168.10.53:4569
  421. [2017-11-08 10:34:19] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7367
  422. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7360 on 12378/59 to 192.168.10.53:4569
  423. [2017-11-08 10:34:19] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7387
  424. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7380 on 12378/59 to 192.168.10.53:4569
  425. [2017-11-08 10:34:19] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7407
  426. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7400 on 12378/59 to 192.168.10.53:4569
  427. [2017-11-08 10:34:19] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7427
  428. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7420 on 12378/59 to 192.168.10.53:4569
  429. [2017-11-08 10:34:19] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7447
  430. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7440 on 12378/59 to 192.168.10.53:4569
  431. [2017-11-08 10:34:19] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7467
  432. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7460 on 12378/59 to 192.168.10.53:4569
  433. [2017-11-08 10:34:19] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7487
  434. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7480 on 12378/59 to 192.168.10.53:4569
  435. [2017-11-08 10:34:19] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7507
  436. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7500 on 12378/59 to 192.168.10.53:4569
  437. [2017-11-08 10:34:19] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7527
  438. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7520 on 12378/59 to 192.168.10.53:4569
  439. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7547
  440. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7540 on 12378/59 to 192.168.10.53:4569
  441. [2017-11-08 10:34:19] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7567
  442. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7560 on 12378/59 to 192.168.10.53:4569
  443. [2017-11-08 10:34:19] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7587
  444. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7580 on 12378/59 to 192.168.10.53:4569
  445. [2017-11-08 10:34:19] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7607
  446. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7600 on 12378/59 to 192.168.10.53:4569
  447. [2017-11-08 10:34:19] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7627
  448. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7620 on 12378/59 to 192.168.10.53:4569
  449. [2017-11-08 10:34:19] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7647
  450. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7640 on 12378/59 to 192.168.10.53:4569
  451. [2017-11-08 10:34:19] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7667
  452. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7660 on 12378/59 to 192.168.10.53:4569
  453. [2017-11-08 10:34:19] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7687
  454. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7680 on 12378/59 to 192.168.10.53:4569
  455. [2017-11-08 10:34:19] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7707
  456. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7700 on 12378/59 to 192.168.10.53:4569
  457. [2017-11-08 10:34:19] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7727
  458. [2017-11-08 10:34:19] DEBUG[2329]: chan_sip.c:8996 __sip_alloc: Allocating new SIP dialog for 39f07b026e30fd0b31d6a4e8015e5750@192.168.10.248:5160 - OPTIONS (No RTP)
  459. [2017-11-08 10:34:19] DEBUG[2329]: acl.c:957 ast_ouraddrfor: For destination '208.100.39.55', our source address is '192.168.10.248'.
  460. [2017-11-08 10:34:19] DEBUG[2329]: chan_sip.c:3910 ast_sip_ouraddrfor: Setting AST_TRANSPORT_UDP with address 192.168.10.248:5160
  461. [2017-11-08 10:34:19] DEBUG[2329]: chan_sip.c:8781 change_callid_pvt: SIP call-id changed from '39f07b026e30fd0b31d6a4e8015e5750@192.168.10.248:5160' to '017c76756423fa7458b7e6003f932756@192.168.10.248:5160'
  462. [2017-11-08 10:34:19] DEBUG[2329]: chan_sip.c:3396 initialize_initreq: Initializing initreq for method OPTIONS - callid 017c76756423fa7458b7e6003f932756@192.168.10.248:5160
  463. [2017-11-08 10:34:19] DEBUG[2329]: chan_sip.c:3753 __sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 208.100.39.55:5080
  464. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7720 on 12378/59 to 192.168.10.53:4569
  465. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7747
  466. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7740 on 12378/59 to 192.168.10.53:4569
  467. [2017-11-08 10:34:19] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7767
  468. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7760 on 12378/59 to 192.168.10.53:4569
  469. [2017-11-08 10:34:19] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7787
  470. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7780 on 12378/59 to 192.168.10.53:4569
  471. [2017-11-08 10:34:19] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7807
  472. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7800 on 12378/59 to 192.168.10.53:4569
  473. [2017-11-08 10:34:19] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7827
  474. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7820 on 12378/59 to 192.168.10.53:4569
  475. [2017-11-08 10:34:19] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7847
  476. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7840 on 12378/59 to 192.168.10.53:4569
  477. [2017-11-08 10:34:19] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7867
  478. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7860 on 12378/59 to 192.168.10.53:4569
  479. [2017-11-08 10:34:19] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7887
  480. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7880 on 12378/59 to 192.168.10.53:4569
  481. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7907
  482. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7900 on 12378/59 to 192.168.10.53:4569
  483. [2017-11-08 10:34:19] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7927
  484. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7920 on 12378/59 to 192.168.10.53:4569
  485. [2017-11-08 10:34:19] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7947
  486. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7940 on 12378/59 to 192.168.10.53:4569
  487. [2017-11-08 10:34:19] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7967
  488. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7960 on 12378/59 to 192.168.10.53:4569
  489. [2017-11-08 10:34:19] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=7987
  490. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 7980 on 12378/59 to 192.168.10.53:4569
  491. [2017-11-08 10:34:19] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8007
  492. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8000 on 12378/59 to 192.168.10.53:4569
  493. [2017-11-08 10:34:19] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8027
  494. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8020 on 12378/59 to 192.168.10.53:4569
  495. [2017-11-08 10:34:19] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8047
  496. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8040 on 12378/59 to 192.168.10.53:4569
  497. [2017-11-08 10:34:19] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8067
  498. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8060 on 12378/59 to 192.168.10.53:4569
  499. [2017-11-08 10:34:19] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8087
  500. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8080 on 12378/59 to 192.168.10.53:4569
  501. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8107
  502. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8100 on 12378/59 to 192.168.10.53:4569
  503. [2017-11-08 10:34:19] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8127
  504. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8120 on 12378/59 to 192.168.10.53:4569
  505. [2017-11-08 10:34:19] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8147
  506. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8140 on 12378/59 to 192.168.10.53:4569
  507. [2017-11-08 10:34:19] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8167
  508. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8160 on 12378/59 to 192.168.10.53:4569
  509. [2017-11-08 10:34:19] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8187
  510. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8180 on 12378/59 to 192.168.10.53:4569
  511. [2017-11-08 10:34:19] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8207
  512. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8200 on 12378/59 to 192.168.10.53:4569
  513. [2017-11-08 10:34:19] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8227
  514. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8220 on 12378/59 to 192.168.10.53:4569
  515. [2017-11-08 10:34:19] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8247
  516. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8240 on 12378/59 to 192.168.10.53:4569
  517. [2017-11-08 10:34:19] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8267
  518. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8260 on 12378/59 to 192.168.10.53:4569
  519. [2017-11-08 10:34:19] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8287
  520. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8280 on 12378/59 to 192.168.10.53:4569
  521. [2017-11-08 10:34:19] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8307
  522. [2017-11-08 10:34:19] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8300 on 12378/59 to 192.168.10.53:4569
  523. [2017-11-08 10:34:20] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8327
  524. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8320 on 12378/59 to 192.168.10.53:4569
  525. [2017-11-08 10:34:20] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8347
  526. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8340 on 12378/59 to 192.168.10.53:4569
  527. [2017-11-08 10:34:20] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8367
  528. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8360 on 12378/59 to 192.168.10.53:4569
  529. [2017-11-08 10:34:20] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8387
  530. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8380 on 12378/59 to 192.168.10.53:4569
  531. [2017-11-08 10:34:20] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8407
  532. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8400 on 12378/59 to 192.168.10.53:4569
  533. [2017-11-08 10:34:20] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8427
  534. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8420 on 12378/59 to 192.168.10.53:4569
  535. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8447
  536. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8440 on 12378/59 to 192.168.10.53:4569
  537. [2017-11-08 10:34:20] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8467
  538. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8460 on 12378/59 to 192.168.10.53:4569
  539. [2017-11-08 10:34:20] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8487
  540. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8480 on 12378/59 to 192.168.10.53:4569
  541. [2017-11-08 10:34:20] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8507
  542. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8500 on 12378/59 to 192.168.10.53:4569
  543. [2017-11-08 10:34:20] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8527
  544. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8520 on 12378/59 to 192.168.10.53:4569
  545. [2017-11-08 10:34:20] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8547
  546. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8540 on 12378/59 to 192.168.10.53:4569
  547. [2017-11-08 10:34:20] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8567
  548. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8560 on 12378/59 to 192.168.10.53:4569
  549. [2017-11-08 10:34:20] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8587
  550. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8580 on 12378/59 to 192.168.10.53:4569
  551. [2017-11-08 10:34:20] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8607
  552. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8600 on 12378/59 to 192.168.10.53:4569
  553. [2017-11-08 10:34:20] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8627
  554. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8620 on 12378/59 to 192.168.10.53:4569
  555. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8647
  556. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8640 on 12378/59 to 192.168.10.53:4569
  557. [2017-11-08 10:34:20] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8667
  558. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8660 on 12378/59 to 192.168.10.53:4569
  559. [2017-11-08 10:34:20] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8687
  560. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8680 on 12378/59 to 192.168.10.53:4569
  561. [2017-11-08 10:34:20] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8707
  562. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8700 on 12378/59 to 192.168.10.53:4569
  563. [2017-11-08 10:34:20] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8727
  564. [2017-11-08 10:34:20] DEBUG[2329]: chan_sip.c:3753 __sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 208.100.39.55:5080
  565. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8720 on 12378/59 to 192.168.10.53:4569
  566. [2017-11-08 10:34:20] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8747
  567. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8740 on 12378/59 to 192.168.10.53:4569
  568. [2017-11-08 10:34:20] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8767
  569. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8760 on 12378/59 to 192.168.10.53:4569
  570. [2017-11-08 10:34:20] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8787
  571. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8780 on 12378/59 to 192.168.10.53:4569
  572. [2017-11-08 10:34:20] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8807
  573. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8800 on 12378/59 to 192.168.10.53:4569
  574. [2017-11-08 10:34:20] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8827
  575. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8820 on 12378/59 to 192.168.10.53:4569
  576. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8847
  577. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8840 on 12378/59 to 192.168.10.53:4569
  578. [2017-11-08 10:34:20] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8867
  579. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8860 on 12378/59 to 192.168.10.53:4569
  580. [2017-11-08 10:34:20] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8887
  581. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8880 on 12378/59 to 192.168.10.53:4569
  582. [2017-11-08 10:34:20] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8907
  583. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8900 on 12378/59 to 192.168.10.53:4569
  584. [2017-11-08 10:34:20] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8927
  585. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8920 on 12378/59 to 192.168.10.53:4569
  586. [2017-11-08 10:34:20] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8947
  587. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8940 on 12378/59 to 192.168.10.53:4569
  588. [2017-11-08 10:34:20] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8967
  589. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8960 on 12378/59 to 192.168.10.53:4569
  590. [2017-11-08 10:34:20] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=8987
  591. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 8980 on 12378/59 to 192.168.10.53:4569
  592. [2017-11-08 10:34:20] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9007
  593. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9000 on 12378/59 to 192.168.10.53:4569
  594. [2017-11-08 10:34:20] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9027
  595. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9020 on 12378/59 to 192.168.10.53:4569
  596. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9047
  597. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9040 on 12378/59 to 192.168.10.53:4569
  598. [2017-11-08 10:34:20] DEBUG[2319]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9067
  599. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9060 on 12378/59 to 192.168.10.53:4569
  600. [2017-11-08 10:34:20] DEBUG[2317]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9087
  601. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9080 on 12378/59 to 192.168.10.53:4569
  602. [2017-11-08 10:34:20] DEBUG[2325]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9107
  603. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9100 on 12378/59 to 192.168.10.53:4569
  604. [2017-11-08 10:34:20] DEBUG[2318]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9127
  605. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9120 on 12378/59 to 192.168.10.53:4569
  606. [2017-11-08 10:34:20] DEBUG[2321]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9147
  607. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9140 on 12378/59 to 192.168.10.53:4569
  608. [2017-11-08 10:34:20] DEBUG[2320]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9167
  609. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9160 on 12378/59 to 192.168.10.53:4569
  610. [2017-11-08 10:34:20] DEBUG[2326]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9187
  611. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9180 on 12378/59 to 192.168.10.53:4569
  612. [2017-11-08 10:34:20] DEBUG[2324]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9207
  613. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9200 on 12378/59 to 192.168.10.53:4569
  614. [2017-11-08 10:34:20] DEBUG[2322]: chan_iax2.c:11961 socket_process_helper: For call=12378, set last=9227
  615. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3432 send_packet: Sending 9220 on 12378/59 to 192.168.10.53:4569
  616. Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 005 Type: IAX     Subclass: HANGUP
  617.    Timestamp: 09229ms  SCall: 00059  DCall: 12378 192.168.10.53:4569
  618.    CAUSE CODE      : 16
  619.  
  620. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:10379 socket_process_helper: Received packet 3, (6, 5)
  621. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:10650 socket_process_helper: IAX subclass 5 received
  622. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:10659 socket_process_helper: For call=12378, set last=9229
  623. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:10971 socket_process_helper: Immediately destroying 12378, having received hangup
  624. [2017-11-08 10:34:20] DEBUG[2323]: chan_iax2.c:3432 send_packet: Sending 9229 on 12378/59 to 192.168.10.53:4569
  625. Tx-Frame Retry[-01] -- OSeqno: 005 ISeqno: 004 Type: IAX     Subclass: ACK
  626.    Timestamp: 09229ms  SCall: 12378  DCall: 00059 192.168.10.53:4569
  627. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  628. Event: HangupRequest
  629. Privilege: call,all
  630. Channel: IAX2/222-12378
  631. ChannelState: 7
  632. ChannelStateDesc: Busy
  633. CallerIDNum: 222
  634. CallerIDName: Roy
  635. ConnectedLineNum: <unknown>
  636. ConnectedLineName: <unknown>
  637. Language: en
  638. AccountCode:
  639. Context: macro-outisbusy
  640. Exten: s
  641. Priority: 5
  642. Uniqueid: 1510158851.1200
  643. Linkedid: 1510158851.1200
  644.  
  645.  
  646. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  647. Event: HangupRequest
  648. Privilege: call,all
  649. Channel: IAX2/222-12378
  650. ChannelState: 7
  651. ChannelStateDesc: Busy
  652. CallerIDNum: 222
  653. CallerIDName: Roy
  654. ConnectedLineNum: <unknown>
  655. ConnectedLineName: <unknown>
  656. Language: en
  657. AccountCode:
  658. Context: macro-outisbusy
  659. Exten: s
  660. Priority: 5
  661. Uniqueid: 1510158851.1200
  662. Linkedid: 1510158851.1200
  663.  
  664.  
  665. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:3469 ast_settimeout_full: Scheduling timer at (0 requested / 0 actual) timer ticks per second
  666. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:8118 deactivate_silence_generator: Trying to stop silence generator when there is no generator on 'IAX2/222-12378'
  667. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: app_macro.c:453 _macro_exec: Spawn extension (macro-outisbusy,s,5) exited non-zero on 'IAX2/222-12378' in macro 'outisbusy'
  668.   == Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'IAX2/222-12378' in macro 'outisbusy'
  669. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  670. Event: VarSet
  671. Privilege: dialplan,all
  672. Channel: IAX2/222-12378
  673. ChannelState: 7
  674. ChannelStateDesc: Busy
  675. CallerIDNum: 222
  676. CallerIDName: Roy
  677. ConnectedLineNum: <unknown>
  678. ConnectedLineName: <unknown>
  679. Language: en
  680. AccountCode:
  681. Context: macro-outisbusy
  682. Exten: s
  683. Priority: 5
  684. Uniqueid: 1510158851.1200
  685. Linkedid: 1510158851.1200
  686. Variable: MACRO_DEPTH
  687. Value: 0
  688.  
  689.  
  690. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  691. Event: VarSet
  692. Privilege: dialplan,all
  693. Channel: IAX2/222-12378
  694. ChannelState: 7
  695. ChannelStateDesc: Busy
  696. CallerIDNum: 222
  697. CallerIDName: Roy
  698. ConnectedLineNum: <unknown>
  699. ConnectedLineName: <unknown>
  700. Language: en
  701. AccountCode:
  702. Context: macro-outisbusy
  703. Exten: s
  704. Priority: 5
  705. Uniqueid: 1510158851.1200
  706. Linkedid: 1510158851.1200
  707. Variable: MACRO_DEPTH
  708. Value: 0
  709.  
  710.  
  711. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  712. Event: VarSet
  713. Privilege: dialplan,all
  714. Channel: IAX2/222-12378
  715. ChannelState: 7
  716. ChannelStateDesc: Busy
  717. CallerIDNum: 222
  718. CallerIDName: Roy
  719. ConnectedLineNum: <unknown>
  720. ConnectedLineName: <unknown>
  721. Language: en
  722. AccountCode:
  723. Context: macro-outisbusy
  724. Exten: s
  725. Priority: 5
  726. Uniqueid: 1510158851.1200
  727. Linkedid: 1510158851.1200
  728. Variable: MACRO_EXTEN
  729. Value:
  730.  
  731.  
  732. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  733. Event: VarSet
  734. Privilege: dialplan,all
  735. Channel: IAX2/222-12378
  736. ChannelState: 7
  737. ChannelStateDesc: Busy
  738. CallerIDNum: 222
  739. CallerIDName: Roy
  740. ConnectedLineNum: <unknown>
  741. ConnectedLineName: <unknown>
  742. Language: en
  743. AccountCode:
  744. Context: macro-outisbusy
  745. Exten: s
  746. Priority: 5
  747. Uniqueid: 1510158851.1200
  748. Linkedid: 1510158851.1200
  749. Variable: MACRO_EXTEN
  750. Value:
  751.  
  752.  
  753. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  754. Event: VarSet
  755. Privilege: dialplan,all
  756. Channel: IAX2/222-12378
  757. ChannelState: 7
  758. ChannelStateDesc: Busy
  759. CallerIDNum: 222
  760. CallerIDName: Roy
  761. ConnectedLineNum: <unknown>
  762. ConnectedLineName: <unknown>
  763. Language: en
  764. AccountCode:
  765. Context: macro-outisbusy
  766. Exten: s
  767. Priority: 5
  768. Uniqueid: 1510158851.1200
  769. Linkedid: 1510158851.1200
  770. Variable: MACRO_CONTEXT
  771. Value:
  772.  
  773.  
  774. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  775. Event: VarSet
  776. Privilege: dialplan,all
  777. Channel: IAX2/222-12378
  778. ChannelState: 7
  779. ChannelStateDesc: Busy
  780. CallerIDNum: 222
  781. CallerIDName: Roy
  782. ConnectedLineNum: <unknown>
  783. ConnectedLineName: <unknown>
  784. Language: en
  785. AccountCode:
  786. Context: macro-outisbusy
  787. Exten: s
  788. Priority: 5
  789. Uniqueid: 1510158851.1200
  790. Linkedid: 1510158851.1200
  791. Variable: MACRO_CONTEXT
  792. Value:
  793.  
  794.  
  795. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  796. Event: VarSet
  797. Privilege: dialplan,all
  798. Channel: IAX2/222-12378
  799. ChannelState: 7
  800. ChannelStateDesc: Busy
  801. CallerIDNum: 222
  802. CallerIDName: Roy
  803. ConnectedLineNum: <unknown>
  804. ConnectedLineName: <unknown>
  805. Language: en
  806. AccountCode:
  807. Context: macro-outisbusy
  808. Exten: s
  809. Priority: 5
  810. Uniqueid: 1510158851.1200
  811. Linkedid: 1510158851.1200
  812. Variable: MACRO_PRIORITY
  813. Value:
  814.  
  815.  
  816. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  817. Event: VarSet
  818. Privilege: dialplan,all
  819. Channel: IAX2/222-12378
  820. ChannelState: 7
  821. ChannelStateDesc: Busy
  822. CallerIDNum: 222
  823. CallerIDName: Roy
  824. ConnectedLineNum: <unknown>
  825. ConnectedLineName: <unknown>
  826. Language: en
  827. AccountCode:
  828. Context: macro-outisbusy
  829. Exten: s
  830. Priority: 5
  831. Uniqueid: 1510158851.1200
  832. Linkedid: 1510158851.1200
  833. Variable: MACRO_PRIORITY
  834. Value:
  835.  
  836.  
  837. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:4346 __ast_pbx_run: Spawn extension (from-internal,4443,7) exited non-zero on 'IAX2/222-12378'
  838.   == Spawn extension (from-internal, 4443, 7) exited non-zero on 'IAX2/222-12378'
  839. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:2579 ast_softhangup_nolock: Soft-Hanging (0x10) up channel 'IAX2/222-12378'
  840. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  841. Event: SoftHangupRequest
  842. Privilege: call,all
  843. Channel: IAX2/222-12378
  844. ChannelState: 7
  845. ChannelStateDesc: Busy
  846. CallerIDNum: 222
  847. CallerIDName: Roy
  848. ConnectedLineNum: <unknown>
  849. ConnectedLineName: <unknown>
  850. Language: en
  851. AccountCode:
  852. Context: from-internal
  853. Exten: 4443
  854. Priority: 7
  855. Uniqueid: 1510158851.1200
  856. Linkedid: 1510158851.1200
  857. Cause: 16
  858.  
  859.  
  860. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  861. Event: SoftHangupRequest
  862. Privilege: call,all
  863. Channel: IAX2/222-12378
  864. ChannelState: 7
  865. ChannelStateDesc: Busy
  866. CallerIDNum: 222
  867. CallerIDName: Roy
  868. ConnectedLineNum: <unknown>
  869. ConnectedLineName: <unknown>
  870. Language: en
  871. AccountCode:
  872. Context: from-internal
  873. Exten: 4443
  874. Priority: 7
  875. Uniqueid: 1510158851.1200
  876. Linkedid: 1510158851.1200
  877. Cause: 16
  878.  
  879.  
  880. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:2579 ast_softhangup_nolock: Soft-Hanging (0x80) up channel 'IAX2/222-12378'
  881. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:2875 pbx_extension_helper: Launching 'Macro'
  882.     -- Executing [h@from-internal:1] Macro("IAX2/222-12378", "hangupcall") in new stack
  883. [2017-11-08 10:34:20] DEBUG[2209]: cdr.c:1293 cdr_object_finalize: Finalized CDR for IAX2/222-12378 - start 1510158851.678210 answer 0.000000 end 1510158860.919875 dispo FAILED
  884. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  885. Event: Newexten
  886. Privilege: call,all
  887. Channel: IAX2/222-12378
  888. ChannelState: 7
  889. ChannelStateDesc: Busy
  890. CallerIDNum: 222
  891. CallerIDName: Roy
  892. ConnectedLineNum: <unknown>
  893. ConnectedLineName: <unknown>
  894. Language: en
  895. AccountCode:
  896. Context: from-internal
  897. Exten: h
  898. Priority: 1
  899. Uniqueid: 1510158851.1200
  900. Linkedid: 1510158851.1200
  901. Extension: h
  902. Application: Macro
  903. AppData: hangupcall
  904.  
  905.  
  906. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  907. Event: Newexten
  908. Privilege: call,all
  909. Channel: IAX2/222-12378
  910. ChannelState: 7
  911. ChannelStateDesc: Busy
  912. CallerIDNum: 222
  913. CallerIDName: Roy
  914. ConnectedLineNum: <unknown>
  915. ConnectedLineName: <unknown>
  916. Language: en
  917. AccountCode:
  918. Context: from-internal
  919. Exten: h
  920. Priority: 1
  921. Uniqueid: 1510158851.1200
  922. Linkedid: 1510158851.1200
  923. Extension: h
  924. Application: Macro
  925. AppData: hangupcall
  926.  
  927.  
  928. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  929. Event: VarSet
  930. Privilege: dialplan,all
  931. Channel: IAX2/222-12378
  932. ChannelState: 7
  933. ChannelStateDesc: Busy
  934. CallerIDNum: 222
  935. CallerIDName: Roy
  936. ConnectedLineNum: <unknown>
  937. ConnectedLineName: <unknown>
  938. Language: en
  939. AccountCode:
  940. Context: from-internal
  941. Exten: h
  942. Priority: 1
  943. Uniqueid: 1510158851.1200
  944. Linkedid: 1510158851.1200
  945. Variable: MACRO_IN_HANGUP
  946. Value: 1
  947.  
  948.  
  949. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  950. Event: VarSet
  951. Privilege: dialplan,all
  952. Channel: IAX2/222-12378
  953. ChannelState: 7
  954. ChannelStateDesc: Busy
  955. CallerIDNum: 222
  956. CallerIDName: Roy
  957. ConnectedLineNum: <unknown>
  958. ConnectedLineName: <unknown>
  959. Language: en
  960. AccountCode:
  961. Context: from-internal
  962. Exten: h
  963. Priority: 1
  964. Uniqueid: 1510158851.1200
  965. Linkedid: 1510158851.1200
  966. Variable: MACRO_IN_HANGUP
  967. Value: 1
  968.  
  969.  
  970. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  971. Event: VarSet
  972. Privilege: dialplan,all
  973. Channel: IAX2/222-12378
  974. ChannelState: 7
  975. ChannelStateDesc: Busy
  976. CallerIDNum: 222
  977. CallerIDName: Roy
  978. ConnectedLineNum: <unknown>
  979. ConnectedLineName: <unknown>
  980. Language: en
  981. AccountCode:
  982. Context: from-internal
  983. Exten: h
  984. Priority: 1
  985. Uniqueid: 1510158851.1200
  986. Linkedid: 1510158851.1200
  987. Variable: MACRO_EXTEN
  988. Value: h
  989.  
  990.  
  991. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  992. Event: VarSet
  993. Privilege: dialplan,all
  994. Channel: IAX2/222-12378
  995. ChannelState: 7
  996. ChannelStateDesc: Busy
  997. CallerIDNum: 222
  998. CallerIDName: Roy
  999. ConnectedLineNum: <unknown>
  1000. ConnectedLineName: <unknown>
  1001. Language: en
  1002. AccountCode:
  1003. Context: from-internal
  1004. Exten: h
  1005. Priority: 1
  1006. Uniqueid: 1510158851.1200
  1007. Linkedid: 1510158851.1200
  1008. Variable: MACRO_EXTEN
  1009. Value: h
  1010.  
  1011.  
  1012. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1013. Event: VarSet
  1014. Privilege: dialplan,all
  1015. Channel: IAX2/222-12378
  1016. ChannelState: 7
  1017. ChannelStateDesc: Busy
  1018. CallerIDNum: 222
  1019. CallerIDName: Roy
  1020. ConnectedLineNum: <unknown>
  1021. ConnectedLineName: <unknown>
  1022. Language: en
  1023. AccountCode:
  1024. Context: from-internal
  1025. Exten: h
  1026. Priority: 1
  1027. Uniqueid: 1510158851.1200
  1028. Linkedid: 1510158851.1200
  1029. Variable: MACRO_CONTEXT
  1030. Value: from-internal
  1031.  
  1032.  
  1033. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1034. Event: VarSet
  1035. Privilege: dialplan,all
  1036. Channel: IAX2/222-12378
  1037. ChannelState: 7
  1038. ChannelStateDesc: Busy
  1039. CallerIDNum: 222
  1040. CallerIDName: Roy
  1041. ConnectedLineNum: <unknown>
  1042. ConnectedLineName: <unknown>
  1043. Language: en
  1044. AccountCode:
  1045. Context: from-internal
  1046. Exten: h
  1047. Priority: 1
  1048. Uniqueid: 1510158851.1200
  1049. Linkedid: 1510158851.1200
  1050. Variable: MACRO_CONTEXT
  1051. Value: from-internal
  1052.  
  1053.  
  1054. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1055. Event: VarSet
  1056. Privilege: dialplan,all
  1057. Channel: IAX2/222-12378
  1058. ChannelState: 7
  1059. ChannelStateDesc: Busy
  1060. CallerIDNum: 222
  1061. CallerIDName: Roy
  1062. ConnectedLineNum: <unknown>
  1063. ConnectedLineName: <unknown>
  1064. Language: en
  1065. AccountCode:
  1066. Context: from-internal
  1067. Exten: h
  1068. Priority: 1
  1069. Uniqueid: 1510158851.1200
  1070. Linkedid: 1510158851.1200
  1071. Variable: MACRO_PRIORITY
  1072. Value: 1
  1073.  
  1074.  
  1075. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1076. Event: VarSet
  1077. Privilege: dialplan,all
  1078. Channel: IAX2/222-12378
  1079. ChannelState: 7
  1080. ChannelStateDesc: Busy
  1081. CallerIDNum: 222
  1082. CallerIDName: Roy
  1083. ConnectedLineNum: <unknown>
  1084. ConnectedLineName: <unknown>
  1085. Language: en
  1086. AccountCode:
  1087. Context: from-internal
  1088. Exten: h
  1089. Priority: 1
  1090. Uniqueid: 1510158851.1200
  1091. Linkedid: 1510158851.1200
  1092. Variable: MACRO_PRIORITY
  1093. Value: 1
  1094.  
  1095.  
  1096. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1097. Event: VarSet
  1098. Privilege: dialplan,all
  1099. Channel: IAX2/222-12378
  1100. ChannelState: 7
  1101. ChannelStateDesc: Busy
  1102. CallerIDNum: 222
  1103. CallerIDName: Roy
  1104. ConnectedLineNum: <unknown>
  1105. ConnectedLineName: <unknown>
  1106. Language: en
  1107. AccountCode:
  1108. Context: from-internal
  1109. Exten: h
  1110. Priority: 1
  1111. Uniqueid: 1510158851.1200
  1112. Linkedid: 1510158851.1200
  1113. Variable: MACRO_DEPTH
  1114. Value: 1
  1115.  
  1116.  
  1117. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1118. Event: VarSet
  1119. Privilege: dialplan,all
  1120. Channel: IAX2/222-12378
  1121. ChannelState: 7
  1122. ChannelStateDesc: Busy
  1123. CallerIDNum: 222
  1124. CallerIDName: Roy
  1125. ConnectedLineNum: <unknown>
  1126. ConnectedLineName: <unknown>
  1127. Language: en
  1128. AccountCode:
  1129. Context: from-internal
  1130. Exten: h
  1131. Priority: 1
  1132. Uniqueid: 1510158851.1200
  1133. Linkedid: 1510158851.1200
  1134. Variable: MACRO_DEPTH
  1135. Value: 1
  1136.  
  1137.  
  1138. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1139. Event: VarSet
  1140. Privilege: dialplan,all
  1141. Channel: IAX2/222-12378
  1142. ChannelState: 7
  1143. ChannelStateDesc: Busy
  1144. CallerIDNum: 222
  1145. CallerIDName: Roy
  1146. ConnectedLineNum: <unknown>
  1147. ConnectedLineName: <unknown>
  1148. Language: en
  1149. AccountCode:
  1150. Context: from-internal
  1151. Exten: h
  1152. Priority: 1
  1153. Uniqueid: 1510158851.1200
  1154. Linkedid: 1510158851.1200
  1155. Variable: MACRO_DEPTH
  1156. Value: 1
  1157.  
  1158.  
  1159. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1160. Event: VarSet
  1161. Privilege: dialplan,all
  1162. Channel: IAX2/222-12378
  1163. ChannelState: 7
  1164. ChannelStateDesc: Busy
  1165. CallerIDNum: 222
  1166. CallerIDName: Roy
  1167. ConnectedLineNum: <unknown>
  1168. ConnectedLineName: <unknown>
  1169. Language: en
  1170. AccountCode:
  1171. Context: from-internal
  1172. Exten: h
  1173. Priority: 1
  1174. Uniqueid: 1510158851.1200
  1175. Linkedid: 1510158851.1200
  1176. Variable: MACRO_DEPTH
  1177. Value: 1
  1178.  
  1179.  
  1180. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'USE_CONFIRMATION' is NULL
  1181. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'RINGGROUP_INDEX' is NULL
  1182. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:381 ast_str_retrieve_variable: Result of 'CHANNEL' is 'IAX2/222-12378'
  1183. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'UNIQCHAN' is NULL
  1184. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:777 pbx_substitute_variables_helper_full: Expression result is '1'
  1185. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:2875 pbx_extension_helper: Launching 'GotoIf'
  1186.     -- Executing [s@macro-hangupcall:1] GotoIf("IAX2/222-12378", "1?theend") in new stack
  1187. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1188. Event: Newexten
  1189. Privilege: call,all
  1190. Channel: IAX2/222-12378
  1191. ChannelState: 7
  1192. ChannelStateDesc: Busy
  1193. CallerIDNum: 222
  1194. CallerIDName: Roy
  1195. ConnectedLineNum: <unknown>
  1196. ConnectedLineName: <unknown>
  1197. Language: en
  1198. AccountCode:
  1199. Context: macro-hangupcall
  1200. Exten: s
  1201. Priority: 1
  1202. Uniqueid: 1510158851.1200
  1203. Linkedid: 1510158851.1200
  1204. Extension: s
  1205. Application: GotoIf
  1206. AppData: 1?theend
  1207.  
  1208.  
  1209. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1210. Event: Newexten
  1211. Privilege: call,all
  1212. Channel: IAX2/222-12378
  1213. ChannelState: 7
  1214. ChannelStateDesc: Busy
  1215. CallerIDNum: 222
  1216. CallerIDName: Roy
  1217. ConnectedLineNum: <unknown>
  1218. ConnectedLineName: <unknown>
  1219. Language: en
  1220. AccountCode:
  1221. Context: macro-hangupcall
  1222. Exten: s
  1223. Priority: 1
  1224. Uniqueid: 1510158851.1200
  1225. Linkedid: 1510158851.1200
  1226. Extension: s
  1227. Application: GotoIf
  1228. AppData: 1?theend
  1229.  
  1230.  
  1231.     -- Goto (macro-hangupcall,s,3)
  1232. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: app_macro.c:459 _macro_exec: Executed application: GotoIf
  1233. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1234. Event: VarSet
  1235. Privilege: dialplan,all
  1236. Channel: IAX2/222-12378
  1237. ChannelState: 7
  1238. ChannelStateDesc: Busy
  1239. CallerIDNum: 222
  1240. CallerIDName: Roy
  1241. ConnectedLineNum: <unknown>
  1242. ConnectedLineName: <unknown>
  1243. Language: en
  1244. AccountCode:
  1245. Context: macro-hangupcall
  1246. Exten: s
  1247. Priority: 1
  1248. Uniqueid: 1510158851.1200
  1249. Linkedid: 1510158851.1200
  1250. Variable: MACRO_DEPTH
  1251. Value: 1
  1252.  
  1253.  
  1254. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1255. Event: VarSet
  1256. Privilege: dialplan,all
  1257. Channel: IAX2/222-12378
  1258. ChannelState: 7
  1259. ChannelStateDesc: Busy
  1260. CallerIDNum: 222
  1261. CallerIDName: Roy
  1262. ConnectedLineNum: <unknown>
  1263. ConnectedLineName: <unknown>
  1264. Language: en
  1265. AccountCode:
  1266. Context: macro-hangupcall
  1267. Exten: s
  1268. Priority: 1
  1269. Uniqueid: 1510158851.1200
  1270. Linkedid: 1510158851.1200
  1271. Variable: MACRO_DEPTH
  1272. Value: 1
  1273.  
  1274.  
  1275. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'ONETOUCH_RECFILE' is NULL
  1276. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:708 pbx_substitute_variables_helper_full: Function CDR(recordingfile) result is ''
  1277. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:777 pbx_substitute_variables_helper_full: Expression result is '0'
  1278. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'ONETOUCH_RECFILE' is NULL
  1279. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:2875 pbx_extension_helper: Launching 'ExecIf'
  1280.     -- Executing [s@macro-hangupcall:3] ExecIf("IAX2/222-12378", "0?Set(CDR(recordingfile)=)") in new stack
  1281. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1282. Event: Newexten
  1283. Privilege: call,all
  1284. Channel: IAX2/222-12378
  1285. ChannelState: 7
  1286. ChannelStateDesc: Busy
  1287. CallerIDNum: 222
  1288. CallerIDName: Roy
  1289. ConnectedLineNum: <unknown>
  1290. ConnectedLineName: <unknown>
  1291. Language: en
  1292. AccountCode:
  1293. Context: macro-hangupcall
  1294. Exten: s
  1295. Priority: 3
  1296. Uniqueid: 1510158851.1200
  1297. Linkedid: 1510158851.1200
  1298. Extension: s
  1299. Application: ExecIf
  1300. AppData: 0?Set(CDR(recordingfile)=)
  1301.  
  1302.  
  1303. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1304. Event: Newexten
  1305. Privilege: call,all
  1306. Channel: IAX2/222-12378
  1307. ChannelState: 7
  1308. ChannelStateDesc: Busy
  1309. CallerIDNum: 222
  1310. CallerIDName: Roy
  1311. ConnectedLineNum: <unknown>
  1312. ConnectedLineName: <unknown>
  1313. Language: en
  1314. AccountCode:
  1315. Context: macro-hangupcall
  1316. Exten: s
  1317. Priority: 3
  1318. Uniqueid: 1510158851.1200
  1319. Linkedid: 1510158851.1200
  1320. Extension: s
  1321. Application: ExecIf
  1322. AppData: 0?Set(CDR(recordingfile)=)
  1323.  
  1324.  
  1325. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: app_macro.c:459 _macro_exec: Executed application: ExecIf
  1326. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:474 ast_str_substitute_variables_full: Evaluating 'ONETOUCH_RECFILE' (from 'ONETOUCH_RECFILE}"!="" & "${CDR(recordingfile)}"=""' len 16)
  1327. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'ONETOUCH_RECFILE' is NULL
  1328. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:474 ast_str_substitute_variables_full: Evaluating 'CDR(recordingfile)' (from 'CDR(recordingfile)}"=""' len 18)
  1329. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:508 ast_str_substitute_variables_full: Function CDR(recordingfile) result is ''
  1330. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:566 ast_str_substitute_variables_full: Expression result is '0'
  1331. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:474 ast_str_substitute_variables_full: Evaluating 'ONETOUCH_RECFILE' (from 'ONETOUCH_RECFILE})' len 16)
  1332. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx_variables.c:378 ast_str_retrieve_variable: Result of 'ONETOUCH_RECFILE' is NULL
  1333. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1334. Event: VarSet
  1335. Privilege: dialplan,all
  1336. Channel: IAX2/222-12378
  1337. ChannelState: 7
  1338. ChannelStateDesc: Busy
  1339. CallerIDNum: 222
  1340. CallerIDName: Roy
  1341. ConnectedLineNum: <unknown>
  1342. ConnectedLineName: <unknown>
  1343. Language: en
  1344. AccountCode:
  1345. Context: macro-hangupcall
  1346. Exten: s
  1347. Priority: 3
  1348. Uniqueid: 1510158851.1200
  1349. Linkedid: 1510158851.1200
  1350. Variable: MACRO_DEPTH
  1351. Value: 1
  1352.  
  1353.  
  1354. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1355. Event: VarSet
  1356. Privilege: dialplan,all
  1357. Channel: IAX2/222-12378
  1358. ChannelState: 7
  1359. ChannelStateDesc: Busy
  1360. CallerIDNum: 222
  1361. CallerIDName: Roy
  1362. ConnectedLineNum: <unknown>
  1363. ConnectedLineName: <unknown>
  1364. Language: en
  1365. AccountCode:
  1366. Context: macro-hangupcall
  1367. Exten: s
  1368. Priority: 3
  1369. Uniqueid: 1510158851.1200
  1370. Linkedid: 1510158851.1200
  1371. Variable: MACRO_DEPTH
  1372. Value: 1
  1373.  
  1374.  
  1375. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:2875 pbx_extension_helper: Launching 'Hangup'
  1376.     -- Executing [s@macro-hangupcall:4] Hangup("IAX2/222-12378", "") in new stack
  1377. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1378. Event: Newexten
  1379. Privilege: call,all
  1380. Channel: IAX2/222-12378
  1381. ChannelState: 7
  1382. ChannelStateDesc: Busy
  1383. CallerIDNum: 222
  1384. CallerIDName: Roy
  1385. ConnectedLineNum: <unknown>
  1386. ConnectedLineName: <unknown>
  1387. Language: en
  1388. AccountCode:
  1389. Context: macro-hangupcall
  1390. Exten: s
  1391. Priority: 4
  1392. Uniqueid: 1510158851.1200
  1393. Linkedid: 1510158851.1200
  1394. Extension: s
  1395. Application: Hangup
  1396. AppData:
  1397.  
  1398.  
  1399. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1400. Event: Newexten
  1401. Privilege: call,all
  1402. Channel: IAX2/222-12378
  1403. ChannelState: 7
  1404. ChannelStateDesc: Busy
  1405. CallerIDNum: 222
  1406. CallerIDName: Roy
  1407. ConnectedLineNum: <unknown>
  1408. ConnectedLineName: <unknown>
  1409. Language: en
  1410. AccountCode:
  1411. Context: macro-hangupcall
  1412. Exten: s
  1413. Priority: 4
  1414. Uniqueid: 1510158851.1200
  1415. Linkedid: 1510158851.1200
  1416. Extension: s
  1417. Application: Hangup
  1418. AppData:
  1419.  
  1420.  
  1421. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:2579 ast_softhangup_nolock: Soft-Hanging (0x20) up channel 'IAX2/222-12378'
  1422. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: app_macro.c:453 _macro_exec: Spawn extension (macro-hangupcall,s,4) exited non-zero on 'IAX2/222-12378' in macro 'hangupcall'
  1423.   == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'IAX2/222-12378' in macro 'hangupcall'
  1424. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1425. Event: VarSet
  1426. Privilege: dialplan,all
  1427. Channel: IAX2/222-12378
  1428. ChannelState: 7
  1429. ChannelStateDesc: Busy
  1430. CallerIDNum: 222
  1431. CallerIDName: Roy
  1432. ConnectedLineNum: <unknown>
  1433. ConnectedLineName: <unknown>
  1434. Language: en
  1435. AccountCode:
  1436. Context: macro-hangupcall
  1437. Exten: s
  1438. Priority: 4
  1439. Uniqueid: 1510158851.1200
  1440. Linkedid: 1510158851.1200
  1441. Variable: MACRO_DEPTH
  1442. Value: 0
  1443.  
  1444.  
  1445. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1446. Event: VarSet
  1447. Privilege: dialplan,all
  1448. Channel: IAX2/222-12378
  1449. ChannelState: 7
  1450. ChannelStateDesc: Busy
  1451. CallerIDNum: 222
  1452. CallerIDName: Roy
  1453. ConnectedLineNum: <unknown>
  1454. ConnectedLineName: <unknown>
  1455. Language: en
  1456. AccountCode:
  1457. Context: macro-hangupcall
  1458. Exten: s
  1459. Priority: 4
  1460. Uniqueid: 1510158851.1200
  1461. Linkedid: 1510158851.1200
  1462. Variable: MACRO_DEPTH
  1463. Value: 0
  1464.  
  1465.  
  1466. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1467. Event: VarSet
  1468. Privilege: dialplan,all
  1469. Channel: IAX2/222-12378
  1470. ChannelState: 7
  1471. ChannelStateDesc: Busy
  1472. CallerIDNum: 222
  1473. CallerIDName: Roy
  1474. ConnectedLineNum: <unknown>
  1475. ConnectedLineName: <unknown>
  1476. Language: en
  1477. AccountCode:
  1478. Context: macro-hangupcall
  1479. Exten: s
  1480. Priority: 4
  1481. Uniqueid: 1510158851.1200
  1482. Linkedid: 1510158851.1200
  1483. Variable: MACRO_EXTEN
  1484. Value:
  1485.  
  1486.  
  1487. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1488. Event: VarSet
  1489. Privilege: dialplan,all
  1490. Channel: IAX2/222-12378
  1491. ChannelState: 7
  1492. ChannelStateDesc: Busy
  1493. CallerIDNum: 222
  1494. CallerIDName: Roy
  1495. ConnectedLineNum: <unknown>
  1496. ConnectedLineName: <unknown>
  1497. Language: en
  1498. AccountCode:
  1499. Context: macro-hangupcall
  1500. Exten: s
  1501. Priority: 4
  1502. Uniqueid: 1510158851.1200
  1503. Linkedid: 1510158851.1200
  1504. Variable: MACRO_EXTEN
  1505. Value:
  1506.  
  1507.  
  1508. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1509. Event: VarSet
  1510. Privilege: dialplan,all
  1511. Channel: IAX2/222-12378
  1512. ChannelState: 7
  1513. ChannelStateDesc: Busy
  1514. CallerIDNum: 222
  1515. CallerIDName: Roy
  1516. ConnectedLineNum: <unknown>
  1517. ConnectedLineName: <unknown>
  1518. Language: en
  1519. AccountCode:
  1520. Context: macro-hangupcall
  1521. Exten: s
  1522. Priority: 4
  1523. Uniqueid: 1510158851.1200
  1524. Linkedid: 1510158851.1200
  1525. Variable: MACRO_CONTEXT
  1526. Value:
  1527.  
  1528.  
  1529. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1530. Event: VarSet
  1531. Privilege: dialplan,all
  1532. Channel: IAX2/222-12378
  1533. ChannelState: 7
  1534. ChannelStateDesc: Busy
  1535. CallerIDNum: 222
  1536. CallerIDName: Roy
  1537. ConnectedLineNum: <unknown>
  1538. ConnectedLineName: <unknown>
  1539. Language: en
  1540. AccountCode:
  1541. Context: macro-hangupcall
  1542. Exten: s
  1543. Priority: 4
  1544. Uniqueid: 1510158851.1200
  1545. Linkedid: 1510158851.1200
  1546. Variable: MACRO_CONTEXT
  1547. Value:
  1548.  
  1549.  
  1550. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1551. Event: VarSet
  1552. Privilege: dialplan,all
  1553. Channel: IAX2/222-12378
  1554. ChannelState: 7
  1555. ChannelStateDesc: Busy
  1556. CallerIDNum: 222
  1557. CallerIDName: Roy
  1558. ConnectedLineNum: <unknown>
  1559. ConnectedLineName: <unknown>
  1560. Language: en
  1561. AccountCode:
  1562. Context: macro-hangupcall
  1563. Exten: s
  1564. Priority: 4
  1565. Uniqueid: 1510158851.1200
  1566. Linkedid: 1510158851.1200
  1567. Variable: MACRO_PRIORITY
  1568. Value:
  1569.  
  1570.  
  1571. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1572. Event: VarSet
  1573. Privilege: dialplan,all
  1574. Channel: IAX2/222-12378
  1575. ChannelState: 7
  1576. ChannelStateDesc: Busy
  1577. CallerIDNum: 222
  1578. CallerIDName: Roy
  1579. ConnectedLineNum: <unknown>
  1580. ConnectedLineName: <unknown>
  1581. Language: en
  1582. AccountCode:
  1583. Context: macro-hangupcall
  1584. Exten: s
  1585. Priority: 4
  1586. Uniqueid: 1510158851.1200
  1587. Linkedid: 1510158851.1200
  1588. Variable: MACRO_PRIORITY
  1589. Value:
  1590.  
  1591.  
  1592. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: pbx.c:4157 ast_pbx_h_exten_run: Spawn extension (from-internal,h,1) exited non-zero on 'IAX2/222-12378'
  1593.   == Spawn extension (from-internal, h, 1) exited non-zero on 'IAX2/222-12378'
  1594. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: channel.c:2728 ast_hangup: Hanging up channel 'IAX2/222-12378'
  1595. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:5318 iax2_hangup: We're hanging up IAX2/222-12378 now...
  1596. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1597. Event: HangupRequest
  1598. Privilege: call,all
  1599. Channel: IAX2/222-12378
  1600. ChannelState: 7
  1601. ChannelStateDesc: Busy
  1602. CallerIDNum: 222
  1603. CallerIDName: Roy
  1604. ConnectedLineNum: <unknown>
  1605. ConnectedLineName: <unknown>
  1606. Language: en
  1607. AccountCode:
  1608. Context: from-internal
  1609. Exten: h
  1610. Priority: 1
  1611. Uniqueid: 1510158851.1200
  1612. Linkedid: 1510158851.1200
  1613.  
  1614.  
  1615. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1616. Event: HangupRequest
  1617. Privilege: call,all
  1618. Channel: IAX2/222-12378
  1619. ChannelState: 7
  1620. ChannelStateDesc: Busy
  1621. CallerIDNum: 222
  1622. CallerIDName: Roy
  1623. ConnectedLineNum: <unknown>
  1624. ConnectedLineName: <unknown>
  1625. Language: en
  1626. AccountCode:
  1627. Context: from-internal
  1628. Exten: h
  1629. Priority: 1
  1630. Uniqueid: 1510158851.1200
  1631. Linkedid: 1510158851.1200
  1632.  
  1633.  
  1634. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:5335 iax2_hangup: Really destroying IAX2/222-12378 now...
  1635. [2017-11-08 10:34:20] DEBUG[1795][C-00000082]: chan_iax2.c:3083 sched_delay_remove: schedule decrement of callno used for 192.168.10.53 in 60 seconds
  1636.     -- Hungup 'IAX2/222-12378'
  1637. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:865 _ast_odbc_request_obj2: Reusing ODBC handle 0x7f6fc8060970 from class 'asteriskcdrdb'
  1638. [2017-11-08 10:34:20] DEBUG[2213]: cel_odbc.c:766 odbc_log: Executing SQL statement: [INSERT INTO cel (eventtype,eventtime,cid_name,cid_num,cid_ani,cid_rdnis,cid_dnid,exten,context,channame,appname,appdata,amaflags,accountcode,uniqueid,linkedid,peer,userdeftype,extra) VALUES ('HANGUP',{ts '2017-11-08 10:34:20.944482'},'Roy','222','222','','4443','h','from-internal','IAX2/222-12378','','',3,'','1510158851.1200','1510158851.1200','','','{"hangupcause":16,"dialstatus":"","hangupsource":"IAX2/222-12378"}')]
  1639. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:714 ast_odbc_release_obj: Releasing ODBC handle 0x7f6fc8060970 into pool
  1640. [2017-11-08 10:34:20] DEBUG[2213]: cel_radius.c:199 radius_log: Unable to create RADIUS record. CEL not recorded!
  1641. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1642. Event: Hangup
  1643. Privilege: call,all
  1644. Channel: IAX2/222-12378
  1645. ChannelState: 7
  1646. ChannelStateDesc: Busy
  1647. CallerIDNum: 222
  1648. CallerIDName: Roy
  1649. ConnectedLineNum: <unknown>
  1650. ConnectedLineName: <unknown>
  1651. Language: en
  1652. AccountCode:
  1653. Context: from-internal
  1654. Exten: h
  1655. Priority: 1
  1656. Uniqueid: 1510158851.1200
  1657. Linkedid: 1510158851.1200
  1658. Cause: 16
  1659. Cause-txt: Normal Clearing
  1660.  
  1661.  
  1662. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1663. Event: Hangup
  1664. Privilege: call,all
  1665. Channel: IAX2/222-12378
  1666. ChannelState: 7
  1667. ChannelStateDesc: Busy
  1668. CallerIDNum: 222
  1669. CallerIDName: Roy
  1670. ConnectedLineNum: <unknown>
  1671. ConnectedLineName: <unknown>
  1672. Language: en
  1673. AccountCode:
  1674. Context: from-internal
  1675. Exten: h
  1676. Priority: 1
  1677. Uniqueid: 1510158851.1200
  1678. Linkedid: 1510158851.1200
  1679. Cause: 16
  1680. Cause-txt: Normal Clearing
  1681.  
  1682.  
  1683. [2017-11-08 10:34:20] DEBUG[2209]: cdr.c:3279 post_cdr: Skipping CDR  for IAX2/222-12378 since we weren't answered
  1684. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:865 _ast_odbc_request_obj2: Reusing ODBC handle 0x7f6fc8060970 from class 'asteriskcdrdb'
  1685. [2017-11-08 10:34:20] DEBUG[2213]: cel_odbc.c:766 odbc_log: Executing SQL statement: [INSERT INTO cel (eventtype,eventtime,cid_name,cid_num,cid_ani,cid_rdnis,cid_dnid,exten,context,channame,appname,appdata,amaflags,accountcode,uniqueid,linkedid,peer,userdeftype,extra) VALUES ('CHAN_END',{ts '2017-11-08 10:34:20.948571'},'Roy','222','222','','4443','h','from-internal','IAX2/222-12378','','',3,'','1510158851.1200','1510158851.1200','','','')]
  1686. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:714 ast_odbc_release_obj: Releasing ODBC handle 0x7f6fc8060970 into pool
  1687. [2017-11-08 10:34:20] DEBUG[2213]: cel_radius.c:199 radius_log: Unable to create RADIUS record. CEL not recorded!
  1688. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:865 _ast_odbc_request_obj2: Reusing ODBC handle 0x7f6fc8060970 from class 'asteriskcdrdb'
  1689. [2017-11-08 10:34:20] DEBUG[2213]: cel_odbc.c:766 odbc_log: Executing SQL statement: [INSERT INTO cel (eventtype,eventtime,cid_name,cid_num,cid_ani,cid_rdnis,cid_dnid,exten,context,channame,appname,appdata,amaflags,accountcode,uniqueid,linkedid,peer,userdeftype,extra) VALUES ('LINKEDID_END',{ts '2017-11-08 10:34:20.950561'},'Roy','222','222','','4443','h','from-internal','IAX2/222-12378','','',3,'','1510158851.1200','1510158851.1200','','','')]
  1690. [2017-11-08 10:34:20] DEBUG[2213]: res_odbc.c:714 ast_odbc_release_obj: Releasing ODBC handle 0x7f6fc8060970 into pool
  1691. [2017-11-08 10:34:20] DEBUG[2213]: cel_radius.c:199 radius_log: Unable to create RADIUS record. CEL not recorded!
  1692. [2017-11-08 10:34:20] DEBUG[2184]: devicestate.c:369 _ast_device_state: No provider found, checking channel drivers for IAX2 - 222
  1693. [2017-11-08 10:34:20] DEBUG[2184]: chan_iax2.c:14492 iax2_devicestate: Checking device state for device 222
  1694. [2017-11-08 10:34:20] DEBUG[2184]: chan_iax2.c:14501 iax2_devicestate: Found peer. What's device state of 222? addr=192.168.10.53:4569, defaddr=(null) maxms=2000, lastms=15
  1695. [2017-11-08 10:34:20] DEBUG[2184]: devicestate.c:474 do_state_change: Changing state for IAX2/222 - state 0 (Unknown)
  1696. [2017-11-08 10:34:20] DEBUG[2211]: devicestate.c:369 _ast_device_state: No provider found, checking channel drivers for IAX2 - 222
  1697. [2017-11-08 10:34:20] DEBUG[2211]: chan_iax2.c:14492 iax2_devicestate: Checking device state for device 222
  1698. [2017-11-08 10:34:20] DEBUG[2211]: chan_iax2.c:14501 iax2_devicestate: Found peer. What's device state of 222? addr=192.168.10.53:4569, defaddr=(null) maxms=2000, lastms=15
  1699. [2017-11-08 10:34:20] DEBUG[2211]: devicestate.c:365 _ast_device_state: Checking if I can find provider for "Custom" - number: DND222
  1700. [2017-11-08 10:34:20] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider SLA with Custom
  1701. [2017-11-08 10:34:20] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider Meetme with Custom
  1702. [2017-11-08 10:34:20] DEBUG[2211]: devicestate.c:454 getproviderstate: Checking provider Custom with Custom
  1703. [2017-11-08 10:34:20] DEBUG[2211]: db.c:376 db_get_common: Unable to find key 'DND222' in family 'CustomDevstate'
  1704. [2017-11-08 10:34:20] DEBUG[2211]: app_queue.c:2566 extension_state_cb: Extension '222@ext-local' changed to state '1' (Not in use) but we don't care because they're not a member of any queue.
  1705. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1706. Event: ExtensionStatus
  1707. Privilege: call,all
  1708. Exten: 222
  1709. Context: ext-local
  1710. Hint: IAX2/222&Custom:DND222,CustomPresence:222
  1711. Status: 0
  1712. StatusText: Idle
  1713.  
  1714.  
  1715. [2017-11-08 10:34:20] DEBUG[2346]: app_queue.c:2491 device_state_cb: Device 'IAX2/222' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
  1716. [2017-11-08 10:34:20] DEBUG[12480]: manager.c:5861 match_filter: Examining AMI event:
  1717. Event: DeviceStateChange
  1718. Privilege: call,all
  1719. Device: IAX2/222
  1720. State: UNKNOWN
  1721.  
  1722.  
  1723. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1724. Event: ExtensionStatus
  1725. Privilege: call,all
  1726. Exten: 222
  1727. Context: ext-local
  1728. Hint: IAX2/222&Custom:DND222,CustomPresence:222
  1729. Status: 0
  1730. StatusText: Idle
  1731.  
  1732.  
  1733. [2017-11-08 10:34:20] DEBUG[2434]: manager.c:5861 match_filter: Examining AMI event:
  1734. Event: DeviceStateChange
  1735. Privilege: call,all
  1736. Device: IAX2/222
  1737. State: UNKNOWN
  1738.  
  1739.  
  1740. [2017-11-08 10:34:21] DEBUG[2329]: chan_sip.c:3753 __sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 208.100.39.55:5080
  1741. [2017-11-08 10:34:22] DEBUG[2329]: chan_sip.c:3753 __sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 208.100.39.55:5080
  1742. [2017-11-08 10:34:23] DEBUG[2329]: chan_sip.c:3753 __sip_xmit: Trying to put 'OPTIONS sip' onto UDP socket destined for 208.100.39.55:5080
  1743. [2017-11-08 10:34:23] DEBUG[2329]: chan_sip.c:6589 sip_pvt_dtor: Destroying SIP dialog 017c76756423fa7458b7e6003f932756@192.168.10.248:5160
  1744. freepbx*CLI> exit
  1745.  

Reply to "call"

Here you can reply to the paste above