1. span style="color: cornflowerblue; font-weight: bold;"> 2024-03-19 14:55:38.304174 [NOTICE] sofia.c:1012 Hangup sofia/default/0686637963 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2. 2024-03-19 14:55:38.304174 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/0686637963]
3. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:653 (sofia/default/0686637963) State EXCHANGE_MEDIA going to sleep
4. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0686637963) Running State Change CS_HANGUP (Cur 20 Tot 536009)
5. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:850 (sofia/default/0686637963) Callstate Change ACTIVE -> HANGUP
6. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:852 (sofia/default/0686637963) State HANGUP
7. 2024-03-19 14:55:38.304174 [DEBUG] mod_sofia.c:438 Channel sofia/default/0686637963 hanging up, cause: NORMAL_CLEARING
8. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:60 sofia/default/0686637963 Standard HANGUP, cause: NORMAL_CLEARING
9. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:852 (sofia/default/0686637963) State HANGUP going to sleep
10. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:619 (sofia/default/0686637963) State Change CS_HANGUP -> CS_REPORTING
11. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0686637963) Running State Change CS_REPORTING (Cur 20 Tot 536009)
12. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:938 (sofia/default/0686637963) State REPORTING
13. 2024-03-19 14:55:38.304174 [INFO] mod_json_cdr.c:271 Process [b2cac45a-e600-11ee-89aa-d17fbcf33421.cdr.json]
14. 2024-03-19 14:55:38.304174 [DEBUG] switch_ivr_bridge.c:706 sofia/default/0686637963 ending bridge by request from write function
15. 2024-03-19 14:55:38.304174 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/default/0117030026@legalaidsa.nebular.co.za:5060]
16. 2024-03-19 14:55:38.304174 [DEBUG] switch_ivr_bridge.c:1712 sofia/default/0686637963 skip receive message [UNBRIDGE] (channel is hungup already)
17. 2024-03-19 14:55:38.304174 [NOTICE] switch_ivr_bridge.c:1764 Hangup sofia/default/0117030026@legalaidsa.nebular.co.za:5060 [CS_EXECUTE] [NORMAL_CLEARING]
18. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_session.c:2815 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
19. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State EXECUTE going to sleep
20. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Running State Change CS_HANGUP (Cur 20 Tot 536009)
21. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:850 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Callstate Change ACTIVE -> HANGUP
22. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:852 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State HANGUP
23. 2024-03-19 14:55:38.304174 [DEBUG] mod_sofia.c:432 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 Overriding SIP cause 480 with 200 from the other leg
24. 2024-03-19 14:55:38.304174 [DEBUG] mod_sofia.c:438 Channel sofia/default/0117030026@legalaidsa.nebular.co.za:5060 hanging up, cause: NORMAL_CLEARING
25. 2024-03-19 14:55:38.304174 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/default/0117030026@legalaidsa.nebular.co.za:5060
26. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:60 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 Standard HANGUP, cause: NORMAL_CLEARING
27. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:852 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State HANGUP going to sleep
28. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:619 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State Change CS_HANGUP -> CS_REPORTING
29. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Running State Change CS_REPORTING (Cur 20 Tot 536009)
30. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:938 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State REPORTING
31. 2024-03-19 14:55:38.304174 [INFO] mod_json_cdr.c:271 Process [b2bb55c4-e600-11ee-8987-d17fbcf33421.cdr.json]
32. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:174 sofia/default/0686637963 Standard REPORTING, cause: NORMAL_CLEARING
33. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:938 (sofia/default/0686637963) State REPORTING going to sleep
34. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:610 (sofia/default/0686637963) State Change CS_REPORTING -> CS_DESTROY
35. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_session.c:1665 Session 536007 (sofia/default/0686637963) Locked, Waiting on external entities
36. 2024-03-19 14:55:38.304174 [NOTICE] switch_core_session.c:1683 Session 536007 (sofia/default/0686637963) Ended
37. 2024-03-19 14:55:38.304174 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/0686637963 [CS_DESTROY]
38. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:741 (sofia/default/0686637963) Running State Change CS_DESTROY (Cur 19 Tot 536009)
39. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:751 (sofia/default/0686637963) State DESTROY
40. 2024-03-19 14:55:38.304174 [DEBUG] mod_sofia.c:343 sofia/default/0686637963 SOFIA DESTROY
41. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:181 sofia/default/0686637963 Standard DESTROY
42. 2024-03-19 14:55:38.304174 [DEBUG] switch_core_state_machine.c:751 (sofia/default/0686637963) State DESTROY going to sleep
43. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:174 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 Standard REPORTING, cause: NORMAL_CLEARING
44. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:938 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State REPORTING going to sleep
45. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:610 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State Change CS_REPORTING -> CS_DESTROY
46. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_session.c:1665 Session 536006 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Locked, Waiting on external entities
47. 2024-03-19 14:55:38.344159 [NOTICE] switch_core_session.c:1683 Session 536006 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Ended
48. 2024-03-19 14:55:38.344159 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/0117030026@legalaidsa.nebular.co.za:5060 [CS_DESTROY]
49. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:741 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) Running State Change CS_DESTROY (Cur 18 Tot 536009)
50. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:751 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State DESTROY
51. 2024-03-19 14:55:38.344159 [DEBUG] mod_sofia.c:343 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 SOFIA DESTROY
52. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:181 sofia/default/0117030026@legalaidsa.nebular.co.za:5060 Standard DESTROY
53. 2024-03-19 14:55:38.344159 [DEBUG] switch_core_state_machine.c:751 (sofia/default/0117030026@legalaidsa.nebular.co.za:5060) State DESTROY going to sleep
54. freeswitch@primary>
55. 2024-03-19 14:55:38.404157 [DEBUG] switch_scheduler.c:144 Deleting task 216770 switch_ivr_schedule_hangup (b2cac45a-e600-11ee-89aa-d17fbcf33421)
56. freeswitch@primary>
57. freeswitch@primary>
58. freeswitch@primary>
59. 2024-03-19 14:55:47.644332 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [completing][200]
60. 2024-03-19 14:55:47.644332 [DEBUG] sofia.c:7094 Remote SDP:
61. v=0                                                                                                                                                                                                                
62. o=3cxPS 120913395712 100042539009 IN IP4 156.38.150.6                                                                                                                                                              
63. s=3cxPS Audio call                                                                                                                                                                                                
64. c=IN IP4 156.38.150.6                                                                                                                                                                                              
65. t=0 0                                                                                                                                                                                                              
66. m=audio 9716 RTP/AVP 18 101                                                                                                                                                                                        
67. a=rtpmap:18 G729/8000                                                                                                                                                                                              
68. a=fmtp:18 annexb=no                                                                                                                                                                                                
69. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
70.  
71. 2024-03-19 14:55:47.644332 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [ready][200]
72. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
73. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
74. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
75. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/6085507138@legalaidsa.nebular.co.za G729/8000 20 ms 160 samples 8000 bits 1 channels
76. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_codec.c:111 sofia/default/6085507138@legalaidsa.nebular.co.za Original read codec set to G729:18
77. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
78. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:4767 sofia/default/6085507138@legalaidsa.nebular.co.za Set 2833 dtmf send payload to 101 recv payload to 101
79. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/6085507138@legalaidsa.nebular.co.za] 156.38.231.107 port 27058 -> 156.38.150.6 port 9716 codec: 18 ms: 20
80. 2024-03-19 14:55:47.644332 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
81. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7180 sofia/default/6085507138@legalaidsa.nebular.co.za Set 2833 dtmf send payload to 101
82. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7187 sofia/default/6085507138@legalaidsa.nebular.co.za Set 2833 dtmf receive payload to 101
83. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7210 sofia/default/6085507138@legalaidsa.nebular.co.za Set rtp dtmf delay to 40
84. 2024-03-19 14:55:47.644332 [NOTICE] sofia.c:8218 Channel [sofia/default/6085507138@legalaidsa.nebular.co.za] has been answered
85. 2024-03-19 14:55:47.644332 [DEBUG] switch_channel.c:3773 (sofia/default/6085507138@legalaidsa.nebular.co.za) Callstate Change RINGING -> ACTIVE
86. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/027693695902@41.160.32.115:5060] 156.38.231.107 port 23398 -> 41.160.32.115 port 22226 codec: 18 ms: 20
87. 2024-03-19 14:55:47.644332 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
88. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7180 sofia/default/027693695902@41.160.32.115:5060 Set 2833 dtmf send payload to 101
89. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7187 sofia/default/027693695902@41.160.32.115:5060 Set 2833 dtmf receive payload to 101
90. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_media.c:7210 sofia/default/027693695902@41.160.32.115:5060 Set rtp dtmf delay to 40
91. 2024-03-19 14:55:47.644332 [DEBUG] mod_sofia.c:850 Local SDP sofia/default/027693695902@41.160.32.115:5060:
92. v=0                                                                                                                                                                                                                
93. o=FreeSWITCH 1710836749 1710836750 IN IP4 156.38.231.107                                                                                                                                                          
94. s=FreeSWITCH                                                                                                                                                                                                      
95. c=IN IP4 156.38.231.107                                                                                                                                                                                            
96. t=0 0                                                                                                                                                                                                              
97. m=audio 23398 RTP/AVP 18 101                                                                                                                                                                                      
98. a=rtpmap:18 G729/8000                                                                                                                                                                                              
99. a=fmtp:18 annexb=yes                                                                                                                                                                                              
100. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
101. a=fmtp:101 0-16                                                                                                                                                                                                    
102. a=ptime:20                                                                                                                                                                                                        
103. a=sendrecv                                                                                                                                                                                                        
104.  
105. 2024-03-19 14:55:47.644332 [NOTICE] switch_ivr_originate.c:3647 Channel [sofia/default/027693695902@41.160.32.115:5060] has been answered
106. 2024-03-19 14:55:47.644332 [DEBUG] switch_channel.c:3773 (sofia/default/027693695902@41.160.32.115:5060) Callstate Change RINGING -> ACTIVE
107. 2024-03-19 14:55:47.644332 [DEBUG] sofia.c:7084 Channel sofia/default/027693695902@41.160.32.115:5060 entering state [completed][200]
108. 2024-03-19 14:55:47.644332 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/default/6085507138@legalaidsa.nebular.co.za]
109. 2024-03-19 14:55:47.644332 [DEBUG] switch_ivr_bridge.c:1614 (sofia/default/6085507138@legalaidsa.nebular.co.za) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
110. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_state_machine.c:584 (sofia/default/6085507138@legalaidsa.nebular.co.za) Running State Change CS_EXCHANGE_MEDIA (Cur 18 Tot 536009)
111. 2024-03-19 14:55:47.644332 [DEBUG] switch_core_state_machine.c:653 (sofia/default/6085507138@legalaidsa.nebular.co.za) State EXCHANGE_MEDIA
112. 2024-03-19 14:55:47.644332 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
113. 2024-03-19 14:55:47.764199 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
114. 2024-03-19 14:55:47.844181 [DEBUG] switch_ivr_bridge.c:546 sofia/default/6085507138@legalaidsa.nebular.co.za Bridge execute app sched_hangup(+6000 normal_clearing)
115. 2024-03-19 14:55:47.864169 [DEBUG] switch_ivr.c:623 sofia/default/6085507138@legalaidsa.nebular.co.za Command Execute sched_hangup(+6000 normal_clearing)
116. EXECUTE sofia/default/6085507138@legalaidsa.nebular.co.za sched_hangup(+6000 normal_clearing)
117. 2024-03-19 14:55:47.864169 [DEBUG] switch_scheduler.c:249 Added task 216771 switch_ivr_schedule_hangup (b916bc56-e600-11ee-89d8-d17fbcf33421) to run at 1710866147
118. 2024-03-19 14:55:47.924177 [INFO] switch_rtp.c:7268 Auto Changing audio port from 156.38.150.6:9716 to 156.38.231.105:9716
119. 2024-03-19 14:55:48.004179 [DEBUG] sofia.c:7084 Channel sofia/default/027693695902@41.160.32.115:5060 entering state [ready][200]
120. 2024-03-19 14:55:49.204183 [NOTICE] switch_channel.c:1104 New Channel sofia/default/0734382646@41.160.32.115:5060 [c60bf002-e600-11ee-89de-d17fbcf33421]
121. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0734382646@41.160.32.115:5060) Running State Change CS_NEW (Cur 19 Tot 536010)
122. 2024-03-19 14:55:49.204183 [DEBUG] sofia.c:9873 sofia/default/0734382646@41.160.32.115:5060 receiving invite from 156.38.231.106:5060 version: 1.6.20  64bit
123. 2024-03-19 14:55:49.204183 [DEBUG] sofia.c:9989 IP 156.38.231.106 Approved by acl "default[]". Access Granted.
124. 2024-03-19 14:55:49.204183 [DEBUG] sofia.c:7084 Channel sofia/default/0734382646@41.160.32.115:5060 entering state [received][100]
125. 2024-03-19 14:55:49.204183 [DEBUG] sofia.c:7094 Remote SDP:
126. v=0                                                                                                                                                                                                                
127. o=HuaweiSoftX3000 111760388460017 111760388460017 IN IP4 41.160.32.115                                                                                                                                            
128. s=-                                                                                                                                                                                                                
129. c=IN IP4 41.160.32.115                                                                                                                                                                                            
130. t=0 0                                                                                                                                                                                                              
131. m=audio 22228 RTP/AVP 18 8 0 101                                                                                                                                                                                  
132. a=rtpmap:18 G729/8000                                                                                                                                                                                              
133. a=fmtp:18 annexb=no                                                                                                                                                                                                
134. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
135. a=rtpmap:0 PCMU/8000                                                                                                                                                                                              
136. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
137. a=fmtp:101 0-15                                                                                                                                                                                                    
138. a=ptime:20                                                                                                                                                                                                        
139.  
140. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:60:8000:1]
141. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4485 Audio Codec Compare [G729:18:8000:60:8000:1] is saved as a near-match
142. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
143. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
144. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
145. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
146. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:60:8000:1]
147. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
148. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
149. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
150. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
151. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:60:8000:1]
152. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
153. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
154. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
155. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
156. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
157. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/0734382646@41.160.32.115:5060 G729/8000 20 ms 160 samples 8000 bits 1 channels
158. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_codec.c:111 sofia/default/0734382646@41.160.32.115:5060 Original read codec set to G729:18
159. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
160. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_media.c:4767 sofia/default/0734382646@41.160.32.115:5060 Set 2833 dtmf send payload to 101 recv payload to 101
161. 2024-03-19 14:55:49.204183 [DEBUG] sofia.c:7507 (sofia/default/0734382646@41.160.32.115:5060) State Change CS_NEW -> CS_INIT
162. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:603 (sofia/default/0734382646@41.160.32.115:5060) State NEW
163. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0734382646@41.160.32.115:5060) Running State Change CS_INIT (Cur 19 Tot 536010)
164. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0734382646@41.160.32.115:5060) State INIT
165. 2024-03-19 14:55:49.204183 [DEBUG] mod_sofia.c:90 sofia/default/0734382646@41.160.32.115:5060 SOFIA INIT
166. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:40 sofia/default/0734382646@41.160.32.115:5060 Standard INIT
167. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:48 (sofia/default/0734382646@41.160.32.115:5060) State Change CS_INIT -> CS_ROUTING
168. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0734382646@41.160.32.115:5060) State INIT going to sleep
169. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0734382646@41.160.32.115:5060) Running State Change CS_ROUTING (Cur 19 Tot 536010)
170. 2024-03-19 14:55:49.204183 [DEBUG] switch_channel.c:2249 (sofia/default/0734382646@41.160.32.115:5060) Callstate Change DOWN -> RINGING
171. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0734382646@41.160.32.115:5060) State ROUTING
172. 2024-03-19 14:55:49.204183 [DEBUG] mod_sofia.c:143 sofia/default/0734382646@41.160.32.115:5060 SOFIA ROUTING
173. 2024-03-19 14:55:49.204183 [DEBUG] switch_core_state_machine.c:236 sofia/default/0734382646@41.160.32.115:5060 Standard ROUTING
174. 2024-03-19 14:55:49.204183 [INFO] mod_dialplan_xml.c:637 Processing 0734382646 <0734382646>->0103130010 in context default
175. 2024-03-19 14:55:49.204183 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fed500f71b0 Connected.
176. 2024-03-19 14:55:49.204183 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
177. 2024-03-19 14:55:49.204183 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
178. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0
179. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 0103130010
180. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0103130010' limit 1
181. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0103130010' AND status=0 limit 1
182. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0103130010' and status=0 LIMIT 1                                                                                                                                                                                                          
183. 2024-03-19 14:55:49.224240 [WARNING] switch_cpp.cpp:1365 [ASTPP] [FAXER] Custom Caller ID
184. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number  : 0734382646 / <null>
185. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0103130010" LIMIT 1                                                                                                                                                              
186. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : inbound
187. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 3673942894]
188. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "3673942894" AND deleted = 0 limit 1
189. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0103130010" AND (accountid = 0 OR status = 1) LIMIT 1
190. 2024-03-19 14:55:49.224240 [NOTICE] switch_cpp.cpp:1365 [ASTPP] Localization Id: 5
191. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 5 AND status=0 limit 1                                                                                                                                                                                                  
192. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Call Direction : inbound
193. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] DID ACCOUNT ID : 15
194. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^0103130010.*' OR patterns = '^010313001.*' OR patterns = '^01031300.*' OR patterns = '^0103130.*' OR patterns = '^010313.*' OR patterns = '^01031.*' OR patterns = '^0103.*' OR patterns = '^010.*' OR patterns = '^01.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 15 ORDER BY LENGTH(PKGPTR.patterns) DESC                                                        
195. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="0103130010" AND A.accountid = '3' limit 1                                                                                                                                                                          
196. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0103130010
197. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0103130010" LIMIT 1                                                                                                                                                              
198. 2024-03-19 14:55:49.224240 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] New Call Direction : inbound
199. 2024-03-19 14:55:49.224240 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0103130010' OR number = '010313001' OR number = '01031300' OR number = '0103130' OR number = '010313' OR number = '01031' OR number = '0103' OR number = '010' OR number = '01' OR number = '0' OR number ='--') OR (number = '0103130010*' OR number = '010313001*' OR number = '01031300*' OR number = '0103130*' OR number = '010313*' OR number = '01031*' OR number = '0103*' OR number = '010*' OR number = '01*' OR number = '0*' OR number ='--') OR (number = '<null>' OR number = '<null' OR number = '<nul' OR number = '<nu' OR number = '<n' OR number = '<' OR number ='--') OR (number = '<null>*' OR number = '<null*' OR number = '<nul*' OR number = '<nu*' OR number = '<n*' OR number = '<*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC                                                                        
200. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] Call Barring Status : -1
201. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '0103130010' OR routing_prefix = '010313001' OR routing_prefix = '01031300' OR routing_prefix = '0103130' OR routing_prefix = '010313' OR routing_prefix = '01031' OR routing_prefix = '0103' OR routing_prefix = '010' OR routing_prefix = '01' OR routing_prefix = '0' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1                                                                                                                      
202. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Account Information ===================
203. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 3
204. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : 3673942894
205. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 10000
206. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
207. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 15
208. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] CID Pool : 0
209. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
210. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 15 AND status = 0
211. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] call_direction :inbound
212. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0103130010" LIMIT 1                                                                                                                                                              
213. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP]  Call Direction : inbound
214. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
215. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 2025
216. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
217. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
218. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 0.00000
219. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Comment : 0103130010
220. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Country Id : 171
221. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 3
222. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
223. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Your10000 balance Accountid 3 !!!
224. 2024-03-19 14:55:49.244184 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Call Is Free - Assigning Max Length  :: 100
225. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] Call Max Length Duration : 100 minutes
226. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] INB_FREE:TRUE
227. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] free_inbound:1
228. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 3 AND status=0 LIMIT 1                                                                                                                                                                                                
229. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] sandip +++++15
230. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "15" AND deleted = 0 limit 1
231. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] Actual CustomerInfo XML:3
232. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] Userinfo XML:3
233. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [userinfo] Actual CustomerInfo XML : 3
234. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 15 limit 1
235. 2024-03-19 14:55:49.244184 [WARNING] switch_cpp.cpp:1365 [ASTPP] [user_domain] User Domain : karlovac.nebular.co.za
236. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP]  Maxlength : 100
237. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
238. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [XML] Customer Recording Flag : 1
239. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [PBX] call_direction : inbound
240. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"0/27".....0734382646
241. 2024-03-19 14:55:49.244184 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : 0734382646
242. 2024-03-19 14:55:49.244184 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 27734382646
243. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"0/27".....<null>
244. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 15 limit 1
245. 2024-03-19 14:55:49.244184 [WARNING] switch_cpp.cpp:1365 [ASTPP] [XML] User Domain : karlovac.nebular.co.za
246. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [XML] Custom Function Name :: custom_inbound_10
247. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] custom_function_name::::::::::1343:::::::::::::::2025
248. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [PBX] call_type : 10
249. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] [PBX] call_type : IVR
250. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_IVR_INFO] Query :SELECT * from pbx_ivr_specification WHERE id = 13 and status=0 LIMIT 1
251. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_RING_GROUP_INFO] Query :SELECT file_name from pbx_recording WHERE id = '37' LIMIT 1
252. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== announcement=File name==================ThistreeRe_.wav
253. 2024-03-19 14:55:49.244184 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== sandip here===========================
254. 2024-03-19 14:55:49.244184 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Generated XML:<?xml version="1.0" encoding="UTF-8" standalone="no"?>
255. <document type="freeswitch/xml">                                                                                                                                                                                  
256. <section name="dialplan" description="ASTPP Dialplan">                                                                                                                                                            
257. <context name="default">                                                                                                                                                                                          
258. <extension name="0103130010">                                                                                                                                                                                      
259. <condition field="destination_number" expression="0103130010">                                                                                                                                                    
260. <action application="set" data="effective_destination_number=0103130010"/>                                                                                                                                        
261. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>                                                                                                                                        
262. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>                                                                                                                              
263. <action application="set" data="callstart=2024-03-19 14:55:49"/>                                                                                                                                                  
264. <action application="set" data="hangup_after_bridge=true"/>                                                                                                                                                        
265. <action application="set" data="continue_on_fail=TRUE"/>                                                                                                                                                          
266. <action application="set" data="account_id=3"/>                                                                                                                                                                    
267. <action application="set" data="parent_id=0"/>                                                                                                                                                                    
268. <action application="set" data="entity_id=3"/>                                                                                                                                                                    
269. <action application="set" data="call_processed=internal"/>                                                                                                                                                        
270. <action application="set" data="call_direction=inbound"/>                                                                                                                                                          
271. <action application="set" data="accountname=default"/>                                                                                                                                                            
272. <action application="set" data="filename1=astpp.pbx.lua"/>                                                                                                                                                        
273. <action application="set" data="origination_rates_did=ID:2025|CODE:^0103130010.*|DESTINATION:0103130010|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:171|ACCID:15"/>                                                                                                                                                                                                      
274. <action application="set" data="origination_rates=0"/>                                                                                                                                                            
275. <action application="set" data="original_caller_id_name=0734382646"/>                                                                                                                                              
276. <action application="set" data="effective_caller_id_name=27734382646"/>                                                                                                                                            
277. <action application="set" data="receiver_accid=15"/>                                                                                                                                                              
278. <action application="export" data="domain_name=karlovac.nebular.co.za"/>                                                                                                                                          
279. <action application="export" data="sip_to_host=karlovac.nebular.co.za"/>                                                                                                                                          
280. <action application="export" data="presence_data=x|||default(3673942894)|||^0103130010.* // 0103130010 // 0.00000||||||DID|||41.160.32.115"/>                                                                      
281. <action application="export" data="call_type=10"/>                                                                                                                                                                
282. <action application="set" data="did_calltype=10"/>                                                                                                                                                                
283. <action application="set" data="did_extensions=13"/>                                                                                                                                                              
284. <action application="set" data="ringback=/var/www/html/astpp//upload/pbx/ThistreeRe_.wav"/>                                                                                                                        
285. <action application="set" data="module_name=pbx"/>                                                                                                                                                                
286. <action application="set" data="sip_h_P-call_type=custom_forward"/>                                                                                                                                                
287. <action application="set" data="sip_h_P-Accountcode=15"/>                                                                                                                                                          
288. <action application="set" data="no_answer_number=145"/>                                                                                                                                                            
289. <action application="export" data="no_answer_number=145"/>                                                                                                                                                        
290. <action application="set" data="no_answer_call_type=extension"/>                                                                                                                                                  
291. <action application="set" data="no_answer_call_type_value=145"/>                                                                                                                                                  
292. <action application="set" data="opensips_flag=0"/>                                                                                                                                                                
293. <action application="set" data="originate_disposition=no_key_press"/>                                                                                                                                              
294. <action application="set" data="variable_sip_to_host=karlovac.nebular.co.za"/>                                                                                                                                    
295. <action application="set" data="userinfo_id=3"/>                                                                                                                                                                  
296. <action application="set" data="variable_sip_to_host=karlovac.nebular.co.za"/>                                                                                                                                    
297. <action application="set" data="original_did_number=0103130010"/>                                                                                                                                                  
298. <action application="set" data="absolute_codec_string=PCMU,PCMA,G729"/>                                                                                                                                            
299.     <action application="answer"/>                                                                                                                                                                                
300. <action application="ivr" data="ThisTree IVR13"/>                                                                                                                                                                  
301. <action application="lua" data="astpp/lib/pbx/astpp-failover_ivr_destination.lua"/>                                                                                                                                
302. </condition>                                                                                                                                                                                                      
303. </extension>                                                                                                                                                                                                      
304. </context>                                                                                                                                                                                                        
305. </section>                                                                                                                                                                                                        
306. </document>                                                                                                                                                                                                        
307. 2024-03-19 14:55:49.244184 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fed500f71b0 released.
308. Dialplan: sofia/default/0734382646@41.160.32.115:5060 parsing [default->0103130010] continue=false
309. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Regex (PASS) [0103130010] destination_number(0103130010) =~ /0103130010/ break=on-false
310. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(effective_destination_number=0103130010)
311. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup)
312. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
313. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(callstart=2024-03-19 14:55:49)
314. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(hangup_after_bridge=true)
315. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(continue_on_fail=TRUE)
316. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(account_id=3)
317. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(parent_id=0)
318. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(entity_id=3)
319. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(call_processed=internal)
320. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(call_direction=inbound)
321. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(accountname=default)
322. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(filename1=astpp.pbx.lua)
323. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(origination_rates_did=ID:2025|CODE:^0103130010.*|DESTINATION:0103130010|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:171|ACCID:15)                                                                                                                                                                      
324. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(origination_rates=0)
325. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(original_caller_id_name=0734382646)
326. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(effective_caller_id_name=27734382646)
327. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(receiver_accid=15)
328. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action export(domain_name=karlovac.nebular.co.za)
329. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action export(sip_to_host=karlovac.nebular.co.za)
330. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action export(presence_data=x|||default(3673942894)|||^0103130010.* // 0103130010 // 0.00000||||||DID|||41.160.32.115)
331. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action export(call_type=10)
332. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(did_calltype=10)
333. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(did_extensions=13)
334. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(ringback=/var/www/html/astpp//upload/pbx/ThistreeRe_.wav)
335. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(module_name=pbx)
336. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(sip_h_P-call_type=custom_forward)
337. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(sip_h_P-Accountcode=15)
338. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(no_answer_number=145)
339. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action export(no_answer_number=145)
340. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(no_answer_call_type=extension)
341. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(no_answer_call_type_value=145)
342. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(opensips_flag=0)
343. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(originate_disposition=no_key_press)
344. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(variable_sip_to_host=karlovac.nebular.co.za)
345. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(userinfo_id=3)
346. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(variable_sip_to_host=karlovac.nebular.co.za)
347. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(original_did_number=0103130010)
348. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action set(absolute_codec_string=PCMU,PCMA,G729)
349. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action answer()
350. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action ivr(ThisTree IVR13)
351. Dialplan: sofia/default/0734382646@41.160.32.115:5060 Action lua(astpp/lib/pbx/astpp-failover_ivr_destination.lua)
352. 2024-03-19 14:55:49.244184 [DEBUG] switch_core_state_machine.c:286 (sofia/default/0734382646@41.160.32.115:5060) State Change CS_ROUTING -> CS_EXECUTE
353. 2024-03-19 14:55:49.244184 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0734382646@41.160.32.115:5060) State ROUTING going to sleep
354. 2024-03-19 14:55:49.244184 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0734382646@41.160.32.115:5060) Running State Change CS_EXECUTE (Cur 19 Tot 536010)
355. 2024-03-19 14:55:49.244184 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0734382646@41.160.32.115:5060) State EXECUTE
356. 2024-03-19 14:55:49.244184 [DEBUG] mod_sofia.c:198 sofia/default/0734382646@41.160.32.115:5060 SOFIA EXECUTE
357. 2024-03-19 14:55:49.244184 [DEBUG] switch_core_state_machine.c:328 sofia/default/0734382646@41.160.32.115:5060 Standard EXECUTE
358. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(effective_destination_number=0103130010)
359. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [effective_destination_number]=[0103130010]
360. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(bridge_pre_execute_bleg_app=sched_hangup)
361. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [bridge_pre_execute_bleg_app]=[sched_hangup]
362. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
363. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
364. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(callstart=2024-03-19 14:55:49)
365. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [callstart]=[2024-03-19 14:55:49]
366. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(hangup_after_bridge=true)
367. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [hangup_after_bridge]=[true]
368. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(continue_on_fail=TRUE)
369. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [continue_on_fail]=[TRUE]
370. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(account_id=3)
371. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [account_id]=[3]
372. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(parent_id=0)
373. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [parent_id]=[0]
374. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(entity_id=3)
375. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [entity_id]=[3]
376. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(call_processed=internal)
377. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [call_processed]=[internal]
378. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(call_direction=inbound)
379. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [call_direction]=[inbound]
380. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(accountname=default)
381. 2024-03-19 14:55:49.244184 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [accountname]=[default]
382. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(filename1=astpp.pbx.lua)
383. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [filename1]=[astpp.pbx.lua]
384. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(origination_rates_did=ID:2025|CODE:^0103130010.*|DESTINATION:0103130010|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:171|ACCID:15)                                                                                                                                                                                
385. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [origination_rates_did]=[ID:2025|CODE:^0103130010.*|DESTINATION:0103130010|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:171|ACCID:15]                                                                                                                              
386. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(origination_rates=0)
387. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [origination_rates]=[0]
388. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(original_caller_id_name=0734382646)
389. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [original_caller_id_name]=[0734382646]
390. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(effective_caller_id_name=27734382646)
391. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [effective_caller_id_name]=[27734382646]
392. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(receiver_accid=15)
393. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [receiver_accid]=[15]
394. EXECUTE sofia/default/0734382646@41.160.32.115:5060 export(domain_name=karlovac.nebular.co.za)
395. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[karlovac.nebular.co.za]
396. EXECUTE sofia/default/0734382646@41.160.32.115:5060 export(sip_to_host=karlovac.nebular.co.za)
397. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [sip_to_host]=[karlovac.nebular.co.za]
398. EXECUTE sofia/default/0734382646@41.160.32.115:5060 export(presence_data=x|||default(3673942894)|||^0103130010.* // 0103130010 // 0.00000||||||DID|||41.160.32.115)
399. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [presence_data]=[x|||default(3673942894)|||^0103130010.* // 0103130010 // 0.00000||||||DID|||41.160.32.115]
400. EXECUTE sofia/default/0734382646@41.160.32.115:5060 export(call_type=10)
401. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_type]=[10]
402. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(did_calltype=10)
403. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [did_calltype]=[10]
404. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(did_extensions=13)
405. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [did_extensions]=[13]
406. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(ringback=/var/www/html/astpp//upload/pbx/ThistreeRe_.wav)
407. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [ringback]=[/var/www/html/astpp//upload/pbx/ThistreeRe_.wav]
408. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(module_name=pbx)
409. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [module_name]=[pbx]
410. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(sip_h_P-call_type=custom_forward)
411. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [sip_h_P-call_type]=[custom_forward]
412. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(sip_h_P-Accountcode=15)
413. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [sip_h_P-Accountcode]=[15]
414. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(no_answer_number=145)
415. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [no_answer_number]=[145]
416. EXECUTE sofia/default/0734382646@41.160.32.115:5060 export(no_answer_number=145)
417. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [no_answer_number]=[145]
418. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(no_answer_call_type=extension)
419. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [no_answer_call_type]=[extension]
420. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(no_answer_call_type_value=145)
421. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [no_answer_call_type_value]=[145]
422. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(opensips_flag=0)
423. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [opensips_flag]=[0]
424. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(originate_disposition=no_key_press)
425. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [originate_disposition]=[no_key_press]
426. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(variable_sip_to_host=karlovac.nebular.co.za)
427. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [variable_sip_to_host]=[karlovac.nebular.co.za]
428. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(userinfo_id=3)
429. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [userinfo_id]=[3]
430. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(variable_sip_to_host=karlovac.nebular.co.za)
431. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [variable_sip_to_host]=[karlovac.nebular.co.za]
432. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(original_did_number=0103130010)
433. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [original_did_number]=[0103130010]
434. EXECUTE sofia/default/0734382646@41.160.32.115:5060 set(absolute_codec_string=PCMU,PCMA,G729)
435. 2024-03-19 14:55:49.264189 [DEBUG] mod_dptools.c:1548 SET sofia/default/0734382646@41.160.32.115:5060 [absolute_codec_string]=[PCMU,PCMA,G729]
436. EXECUTE sofia/default/0734382646@41.160.32.115:5060 answer()
437. 2024-03-19 14:55:49.264189 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/0734382646@41.160.32.115:5060] 156.38.231.107 port 22912 -> 41.160.32.115 port 22228 codec: 18 ms: 20
438. 2024-03-19 14:55:49.264189 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
439. 2024-03-19 14:55:49.264189 [DEBUG] switch_core_media.c:7180 sofia/default/0734382646@41.160.32.115:5060 Set 2833 dtmf send payload to 101
440. 2024-03-19 14:55:49.264189 [DEBUG] switch_core_media.c:7187 sofia/default/0734382646@41.160.32.115:5060 Set 2833 dtmf receive payload to 101
441. 2024-03-19 14:55:49.264189 [DEBUG] switch_core_media.c:7210 sofia/default/0734382646@41.160.32.115:5060 Set rtp dtmf delay to 40
442. 2024-03-19 14:55:49.264189 [DEBUG] mod_sofia.c:850 Local SDP sofia/default/0734382646@41.160.32.115:5060:
443. v=0                                                                                                                                                                                                                
444. o=FreeSWITCH 1710837237 1710837238 IN IP4 156.38.231.107                                                                                                                                                          
445. s=FreeSWITCH                                                                                                                                                                                                      
446. c=IN IP4 156.38.231.107                                                                                                                                                                                            
447. t=0 0                                                                                                                                                                                                              
448. m=audio 22912 RTP/AVP 18 101                                                                                                                                                                                      
449. a=rtpmap:18 G729/8000                                                                                                                                                                                              
450. a=fmtp:18 annexb=no                                                                                                                                                                                                
451. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
452. a=fmtp:101 0-16                                                                                                                                                                                                    
453. a=ptime:20                                                                                                                                                                                                        
454. a=sendrecv                                                                                                                                                                                                        
455.  
456. 2024-03-19 14:55:49.264189 [NOTICE] mod_dptools.c:1312 Channel [sofia/default/0734382646@41.160.32.115:5060] has been answered
457. 2024-03-19 14:55:49.264189 [DEBUG] switch_channel.c:3773 (sofia/default/0734382646@41.160.32.115:5060) Callstate Change RINGING -> ACTIVE
458. 2024-03-19 14:55:49.264189 [DEBUG] sofia.c:7084 Channel sofia/default/0734382646@41.160.32.115:5060 entering state [completed][200]
459. EXECUTE sofia/default/0734382646@41.160.32.115:5060 ivr(ThisTree IVR13)
460. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-exit'
461. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-sub'
462. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-exec-app'
463. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-play-sound'
464. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-back'
465. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-top'
466. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:880 building menu 'ThisTree IVR13'
467. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '1'
468. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '2'
469. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '/^(\d{2,20})$/'
470. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_menu.c:483 Executing IVR menu ThisTree IVR13
471. 2024-03-19 14:55:49.284293 [DEBUG] switch_core_file.c:342 File /var/www/html/astpp/upload/pbx/ThistreeRe_.wav sample rate 44100 doesn't match requested rate 8000
472. 2024-03-19 14:55:49.284293 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
473. 2024-03-19 14:55:49.284293 [INFO] mod_com_g729.c:140 ENCODER LICENSE ALLOCATED--->0x7feda81b5118 0x7feda81b5118
474. 2024-03-19 14:55:49.284293 [INFO] mod_com_g729.c:147 ENCODER CREATED------------->0x7feda81b5118 0x7feda81b5118
475. 2024-03-19 14:55:49.424178 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
476. 2024-03-19 14:55:49.424178 [DEBUG] sofia.c:7084 Channel sofia/default/0734382646@41.160.32.115:5060 entering state [ready][200]
477. 2024-03-19 14:55:53.704170 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF *:1280
478. 2024-03-19 14:55:53.704170 [INFO] switch_channel.c:515 RECV DTMF *:1280
479. 2024-03-19 14:55:53.724178 [DEBUG] switch_rtp.c:5261 Send start packet for [*] ts=2869928968 dur=160/160/1280 seq=43808 lw=2869928968
480. 2024-03-19 14:55:53.744183 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=320/320/1280 seq=43809 lw=2869929128
481. 2024-03-19 14:55:53.764180 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=480/480/1280 seq=43810 lw=2869929288
482. 2024-03-19 14:55:53.784182 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=640/640/1280 seq=43811 lw=2869929448
483. 2024-03-19 14:55:53.804174 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=800/800/1280 seq=43812 lw=2869929608
484. 2024-03-19 14:55:53.824233 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=960/960/1280 seq=43813 lw=2869929768
485. 2024-03-19 14:55:53.844171 [DEBUG] switch_rtp.c:5160 Send middle packet for [*] ts=2869928968 dur=1120/1120/1280 seq=43814 lw=2869929928
486. 2024-03-19 14:55:53.864202 [DEBUG] switch_rtp.c:5160 Send end packet for [*] ts=2869928968 dur=1280/1280/1280 seq=43815 lw=2869929928
487. 2024-03-19 14:55:53.864202 [DEBUG] switch_rtp.c:5160 Send end packet for [*] ts=2869928968 dur=1280/1280/1280 seq=43816 lw=2869929928
488. 2024-03-19 14:55:53.864202 [DEBUG] switch_rtp.c:5160 Send end packet for [*] ts=2869928968 dur=1280/1280/1280 seq=43817 lw=2869929928
489. 2024-03-19 14:55:53.864202 [DEBUG] switch_rtp.c:5108 Queue digit delay of 40ms
490. 2024-03-19 14:55:53.984153 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [received][100]
491. 2024-03-19 14:55:53.984153 [DEBUG] sofia.c:7094 Remote SDP:
492. v=0                                                                                                                                                                                                                
493. o=3cxPS 120913395712 100042539010 IN IP4 156.38.150.6                                                                                                                                                              
494. s=3cxPS Audio call                                                                                                                                                                                                
495. c=IN IP4 156.38.150.6                                                                                                                                                                                              
496. t=0 0                                                                                                                                                                                                              
497. m=audio 9716 RTP/AVP 18 101                                                                                                                                                                                        
498. a=rtpmap:18 G729/8000                                                                                                                                                                                              
499. a=fmtp:18 annexb=no                                                                                                                                                                                                
500. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
501. a=sendonly                                                                                                                                                                                                        
502.  
503. 2024-03-19 14:55:53.984153 [DEBUG] switch_channel.c:1844 (sofia/default/6085507138@legalaidsa.nebular.co.za) Callstate Change ACTIVE -> HELD
504. 2024-03-19 14:55:54.164194 [DEBUG] switch_ivr.c:623 sofia/default/027693695902@41.160.32.115:5060 Command Execute playback(local_stream://moh)
505. EXECUTE sofia/default/027693695902@41.160.32.115:5060 playback(local_stream://moh)
506. 2024-03-19 14:55:54.164194 [DEBUG] mod_local_stream.c:871 Opening Stream [moh/8000] 8000hz
507. 2024-03-19 14:55:54.164194 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
508. 2024-03-19 14:55:54.184189 [INFO] mod_com_g729.c:140 ENCODER LICENSE ALLOCATED--->0x7feda8462df8 0x7feda8462df8
509. 2024-03-19 14:55:54.184189 [INFO] mod_com_g729.c:147 ENCODER CREATED------------->0x7feda8462df8 0x7feda8462df8
510. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
511. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
512. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
513. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
514. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:4767 sofia/default/6085507138@legalaidsa.nebular.co.za Set 2833 dtmf send payload to 101 recv payload to 101
515. 2024-03-19 14:55:54.224173 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/default/6085507138@legalaidsa.nebular.co.za.
516. 2024-03-19 14:55:54.224173 [DEBUG] sofia.c:7999 Processing updated SDP
517. 2024-03-19 14:55:54.224173 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [completed][200]
518. 2024-03-19 14:55:54.244189 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [ready][200]
519. 2024-03-19 14:55:54.404344 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [received][100]
520. 2024-03-19 14:55:54.404344 [DEBUG] sofia.c:7094 Remote SDP:
521. v=0                                                                                                                                                                                                                
522. o=3cxPS 120913395712 100042539011 IN IP4 156.38.150.6                                                                                                                                                              
523. s=3cxPS Audio call                                                                                                                                                                                                
524. c=IN IP4 156.38.150.6                                                                                                                                                                                              
525. t=0 0                                                                                                                                                                                                              
526. m=audio 9716 RTP/AVP 18 101                                                                                                                                                                                        
527. a=rtpmap:18 G729/8000                                                                                                                                                                                              
528. a=fmtp:18 annexb=no                                                                                                                                                                                                
529. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
530.  
531. 2024-03-19 14:55:54.644183 [DEBUG] switch_ivr_play_say.c:1942 done playing file local_stream://moh
532. 2024-03-19 14:55:54.644183 [DEBUG] switch_channel.c:2029 (sofia/default/6085507138@legalaidsa.nebular.co.za) Callstate Change HELD -> UNHELD
533. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
534. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
535. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
536. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
537. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:4767 sofia/default/6085507138@legalaidsa.nebular.co.za Set 2833 dtmf send payload to 101 recv payload to 101
538. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/default/6085507138@legalaidsa.nebular.co.za.
539. 2024-03-19 14:55:54.644183 [DEBUG] sofia.c:7999 Processing updated SDP
540. 2024-03-19 14:55:54.644183 [DEBUG] switch_core_io.c:941 (sofia/default/6085507138@legalaidsa.nebular.co.za) Callstate Change UNHELD -> ACTIVE
541. 2024-03-19 14:55:54.664208 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [completed][200]
542. 2024-03-19 14:55:54.684182 [DEBUG] sofia.c:7084 Channel sofia/default/6085507138@legalaidsa.nebular.co.za entering state [ready][200]
543. 2024-03-19 14:55:54.724181 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
544. 2024-03-19 14:55:56.466850 [NOTICE] switch_channel.c:1104 New Channel sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [ca5f2390-e600-11ee-8a0b-d17fbcf33421]
545. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Running State Change CS_NEW (Cur 20 Tot 536011)
546. 2024-03-19 14:55:56.466850 [DEBUG] sofia.c:9873 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 receiving invite from 156.38.231.106:5060 version: 1.6.20  64bit
547. 2024-03-19 14:55:56.466850 [DEBUG] sofia.c:9989 IP 156.38.231.106 Approved by acl "default[]". Access Granted.
548. 2024-03-19 14:55:56.466850 [DEBUG] sofia.c:7084 Channel sofia/default/0534740341@legalaidsa.nebular.co.za:5060 entering state [received][100]
549. 2024-03-19 14:55:56.466850 [DEBUG] sofia.c:7094 Remote SDP:
550. v=0                                                                                                                                                                                                                
551. o=3cxPS 57696845824 548430413825 IN IP4 156.38.150.6                                                                                                                                                              
552. s=3cxPS Audio call                                                                                                                                                                                                
553. c=IN IP4 156.38.150.6                                                                                                                                                                                              
554. t=0 0                                                                                                                                                                                                              
555. m=audio 9720 RTP/AVP 8 0 9 18 101                                                                                                                                                                                  
556. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
557. a=rtpmap:0 PCMU/8000                                                                                                                                                                                              
558. a=rtpmap:9 G722/8000                                                                                                                                                                                              
559. a=rtpmap:18 G729/8000                                                                                                                                                                                              
560. a=fmtp:18 annexb=no                                                                                                                                                                                                
561. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
562.  
563. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:60:8000:1]
564. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
565. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
566. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
567. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
568. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:60:8000:1]
569. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
570. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
571. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
572. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
573. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G729:18:8000:60:8000:1]
574. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G729:18:8000:20:8000:1]
575. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
576. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
577. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:60:8000:1]
578. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:60:8000:1] ++++ is saved as a match
579. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
580. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
581. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
582. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
583. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
584. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/0534740341@legalaidsa.nebular.co.za:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
585. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_codec.c:111 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Original read codec set to PCMA:8
586. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
587. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_media.c:4767 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Set 2833 dtmf send payload to 101 recv payload to 101
588. 2024-03-19 14:55:56.466850 [DEBUG] sofia.c:7507 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State Change CS_NEW -> CS_INIT
589. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:603 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State NEW
590. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Running State Change CS_INIT (Cur 20 Tot 536011)
591. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State INIT
592. 2024-03-19 14:55:56.466850 [DEBUG] mod_sofia.c:90 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 SOFIA INIT
593. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:40 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Standard INIT
594. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:48 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State Change CS_INIT -> CS_ROUTING
595. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State INIT going to sleep
596. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Running State Change CS_ROUTING (Cur 20 Tot 536011)
597. 2024-03-19 14:55:56.466850 [DEBUG] switch_channel.c:2249 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Callstate Change DOWN -> RINGING
598. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State ROUTING
599. 2024-03-19 14:55:56.466850 [DEBUG] mod_sofia.c:143 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 SOFIA ROUTING
600. 2024-03-19 14:55:56.466850 [DEBUG] switch_core_state_machine.c:236 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Standard ROUTING
601. 2024-03-19 14:55:56.466850 [INFO] mod_dialplan_xml.c:637 Processing 0534740341 <0534740341>->0736001022 in context default
602. 2024-03-19 14:55:56.466850 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fed500f71b0 Connected.
603. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
604. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
605. 2024-03-19 14:55:56.466850 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0
606. 2024-03-19 14:55:56.466850 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 0736001022
607. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0736001022' limit 1
608. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0736001022' AND status=0 limit 1
609. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0736001022' and status=0 LIMIT 1                                                                                                                                                                                                          
610. 2024-03-19 14:55:56.466850 [WARNING] switch_cpp.cpp:1365 [ASTPP] [FAXER] Custom Caller ID
611. 2024-03-19 14:55:56.466850 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number  : 0534740341 / 0534740341
612. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0736001022" LIMIT 1                                                                                                                                                              
613. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0736001022"  AND domains.domain="legalaidsa.nebular.co.za" limit 1                                                                                      
614. 2024-03-19 14:55:56.466850 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : outbound
615. 2024-03-19 14:55:56.466850 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 196083]
616. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "196083" AND deleted = 0 limit 1
617. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^0736001022.*' OR blocked_patterns = '^073600102.*' OR blocked_patterns = '^07360010.*' OR blocked_patterns = '^0736001.*' OR blocked_patterns = '^073600.*' OR blocked_patterns = '^07360.*' OR blocked_patterns = '^0736.*' OR blocked_patterns = '^073.*' OR blocked_patterns = '^07.*' OR blocked_patterns = '^0.*' OR blocked_patterns ='--') AND accountid = 109 limit 1                                                                                                                      
618. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0736001022" AND (accountid = 0 OR status = 1) LIMIT 1
619. 2024-03-19 14:55:56.466850 [NOTICE] switch_cpp.cpp:1365 [ASTPP] Localization Id: 3
620. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 3 AND status=0 limit 1                                                                                                                                                                                                  
621. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0736001022
622. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0736001022
623. 2024-03-19 14:55:56.466850 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^0736001022.*' OR patterns = '^073600102.*' OR patterns = '^07360010.*' OR patterns = '^0736001.*' OR patterns = '^073600.*' OR patterns = '^07360.*' OR patterns = '^0736.*' OR patterns = '^073.*' OR patterns = '^07.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 109 ORDER BY LENGTH(PKGPTR.patterns) DESC                                                        
624. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="0736001022" AND A.accountid = '109' limit 1                                                                                                                                                                        
625. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0736001022
626. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0736001022" LIMIT 1                                                                                                                                                              
627. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0736001022"  AND domains.domain="legalaidsa.nebular.co.za" limit 1                                                                                      
628. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] New Call Direction : outbound
629. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0736001022' OR number = '073600102' OR number = '07360010' OR number = '0736001' OR number = '073600' OR number = '07360' OR number = '0736' OR number = '073' OR number = '07' OR number = '0' OR number ='--') OR (number = '0736001022*' OR number = '073600102*' OR number = '07360010*' OR number = '0736001*' OR number = '073600*' OR number = '07360*' OR number = '0736*' OR number = '073*' OR number = '07*' OR number = '0*' OR number ='--') OR (number = '0534740341' OR number = '053474034' OR number = '05347403' OR number = '0534740' OR number = '053474' OR number = '05347' OR number = '0534' OR number = '053' OR number = '05' OR number = '0' OR number ='--') OR (number = '0534740341*' OR number = '053474034*' OR number = '05347403*' OR number = '0534740*' OR number = '053474*' OR number = '05347*' OR number = '0534*' OR number = '053*' OR number = '05*' OR number = '0*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC                                                                                          
630. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] Call Barring Status : -1
631. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '0736001022' OR routing_prefix = '073600102' OR routing_prefix = '07360010' OR routing_prefix = '0736001' OR routing_prefix = '073600' OR routing_prefix = '07360' OR routing_prefix = '0736' OR routing_prefix = '073' OR routing_prefix = '07' OR routing_prefix = '0' OR routing_prefix ='--') AND status = 0 and reseller_id = 13 limit 1                                                                                                                    
632. 2024-03-19 14:55:56.504170 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Get Destination Number (0736001022)!!!!
633. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Ported Number :27736001022
634. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Query :SELECT rnoroute FROM ported_number WHERE dnfrom ='27736001022' limit 1
635. 2024-03-19 14:55:56.504170 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] After Append Ported Number : (0736001022)!!!!
636. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Account Information ===================
637. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 109
638. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : 196083
639. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 11176.1935
640. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
641. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 93
642. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] CID Pool : 0
643. 2024-03-19 14:55:56.504170 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
644. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
645. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
646. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
647. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
648. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
649. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
650. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
651. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
652. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
653. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
654. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
655. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0534740341
656. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 93 AND status = 0
657. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] call_direction :outbound
658. 2024-03-19 14:55:56.504170 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 93 AND status = 0
659. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^0736001022.*' OR pattern = '^073600102.*' OR pattern = '^07360010.*' OR pattern = '^0736001.*' OR pattern = '^073600.*' OR pattern = '^07360.*' OR pattern = '^0736.*' OR pattern = '^073.*' OR pattern = '^07.*' OR pattern = '^0.*' OR pattern ='--') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 93 OR accountid=109)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC,effective_date DESC LIMIT 1                                                                                      
660. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP]  Call Direction : outbound
661. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
662. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 2148457
663. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
664. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
665. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 0.44000
666. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Comment : SOUTH AFRICA - MTN - MOBILE
667. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Country Id : 0
668. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 109
669. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Trunk ID: 0
670. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Routing type:
671. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
672. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Your11176.1935 balance Accountid 109 !!!
673. 2024-03-19 14:55:56.524192 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
674. 2024-03-19 14:55:56.524192 [NOTICE] switch_cpp.cpp:1365 [ASTPP] FINDING LIMIT FOR RESELLER: 13
675. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "13" AND deleted = 0 limit 1
676. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^0736001022.*' OR blocked_patterns = '^073600102.*' OR blocked_patterns = '^07360010.*' OR blocked_patterns = '^0736001.*' OR blocked_patterns = '^073600.*' OR blocked_patterns = '^07360.*' OR blocked_patterns = '^0736.*' OR blocked_patterns = '^073.*' OR blocked_patterns = '^07.*' OR blocked_patterns = '^0.*' OR blocked_patterns ='--') AND accountid = 13 limit 1                                                                                                                      
677. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Reseller Information ===================
678. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 13
679. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : 778509
680. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 10289.9683
681. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
682. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 83
683. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 83 AND status = 0
684. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] call_direction :outbound
685. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 83 AND status = 0
686. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^0736001022.*' OR pattern = '^073600102.*' OR pattern = '^07360010.*' OR pattern = '^0736001.*' OR pattern = '^073600.*' OR pattern = '^07360.*' OR pattern = '^0736.*' OR pattern = '^073.*' OR pattern = '^07.*' OR pattern = '^0.*' OR pattern ='--') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 83 OR accountid=13)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC,effective_date DESC LIMIT 1                                                                                      
687. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP]  Call Direction : outbound
688. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
689. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 1426359
690. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
691. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
692. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 0.29000
693. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Comment : D083-MTN
694. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Country Id : 0
695. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 13
696. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Trunk ID: 0
697. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Routing type:
698. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
699. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Your10289.9683 balance Accountid 13 !!!
700. 2024-03-19 14:55:56.524192 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
701. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Reseller xml_user_rates : ID:2148457|CODE:^073.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426359|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13                                                                                                                                                                                                              
702. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
703. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Lossless Routing Status : 1
704. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Call Max Length Duration : 100 minutes
705. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] [DIALPLAN] User Rate ID : 2148457
706. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_CARRIER_RATES] Query Rate Carrier Id        :0
707. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_CARRIER_RATES_TRUNKS] Query :SELECT GROUP_CONCAT(trunk_id) as ids FROM routing WHERE pricelist_id=83 ORDER by id asc
708. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_CARRIER_RATES] Query :SELECT TK.id as trunk_id,TK.name as trunk_name,TK.codec,GW.name as path,GW.dialplan_variable,TK.provider_id,TR.init_inc,TK.status,TK.maxchannels,TK.cps,TK.leg_timeout,TR.pattern,TR.id as outbound_route_id,TR.connectcost,TR.comment,TR.includedseconds,TR.cost,TR.inc,TR.prepend,TR.strip,(select name from gateways where status=0 AND id = TK.failover_gateway_id) as path1,(select name from gateways where status=0 AND id = TK.failover_gateway_id1) as path2 FROM outbound_routes as TR,trunks as TK,gateways as GW WHERE GW.status=0 AND GW.id= TK.gateway_id AND TK.status=0 AND TK.id= TR.trunk_id AND (pattern = '^0736001022.*' OR pattern = '^073600102.*' OR pattern = '^07360010.*' OR pattern = '^0736001.*' OR pattern = '^073600.*' OR pattern = '^07360.*' OR pattern = '^0736.*' OR pattern = '^073.*' OR pattern = '^07.*' OR pattern = '^0.*' OR pattern ='--') AND TR.status = 0  AND TR.trunk_id IN (5,7) AND TR.effective_date <= UTC_TIMESTAMP() ORDER by LENGTH (pattern) DESC,TR.cost ASC,TR.precedence ASC, TK.precedence,TR.effective_date DESC                                                                                                                                        
709. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Termination Rates Information ===================
710. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 183
711. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Code : ^0.*
712. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Destination : SA
713. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
714. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Free Seconds : 0
715. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Prefix : ^0.*
716. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Strip :
717. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Prepend :
718. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Carrier id : 5
719. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] carrier_name : liquid_primary
720. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] dialplan_variable :
721. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Failover gateway :
722. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Vendor id : 3
723. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Max channels : 0
724. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] Trunk Name : Liquid
725. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================END OF TERMINATION RATES=======================
726. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 109 AND status=0 LIMIT 1                                                                                                                                                                                              
727. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP]  Maxlength : 100
728. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
729. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] [XML] Customer Recording Flag : 1
730. 2024-03-19 14:55:56.524192 [INFO] switch_cpp.cpp:1365 [ASTPP] [PBX] call_direction : outbound
731. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 83 AND status = 0
732. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from trunks where id = 5) AND status=0 limit 1                                                                                                                                                                            
733. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"+27/0".....0736001022
734. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from accounts where id = 3) AND status=0 limit 1                                                                                                                                                                          
735. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0736001022" LIMIT 1                                                                                                                                                              
736. 2024-03-19 14:55:56.524192 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Generated XML:
737. <?xml version="1.0" encoding="UTF-8" standalone="no"?>                                                                                                                                                            
738. <document type="freeswitch/xml">                                                                                                                                                                                  
739. <section name="dialplan" description="ASTPP Dialplan">                                                                                                                                                            
740. <context name="default">                                                                                                                                                                                          
741. <extension name="0736001022">                                                                                                                                                                                      
742. <condition field="destination_number" expression="0736001022">                                                                                                                                                    
743. <action application="set" data="effective_destination_number=0736001022"/>                                                                                                                                        
744. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>                                                                                                                                        
745. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>                                                                                                                              
746. <action application="set" data="callstart=2024-03-19 14:55:56"/>                                                                                                                                                  
747. <action application="set" data="hangup_after_bridge=true"/>                                                                                                                                                        
748. <action application="set" data="continue_on_fail=TRUE"/>                                                                                                                                                          
749. <action application="set" data="account_id=109"/>                                                                                                                                                                  
750. <action application="set" data="parent_id=13"/>                                                                                                                                                                    
751. <action application="set" data="entity_id=0"/>                                                                                                                                                                    
752. <action application="set" data="call_processed=internal"/>                                                                                                                                                        
753. <action application="set" data="call_direction=outbound"/>                                                                                                                                                        
754. <action application="set" data="accountname=default"/>                                                                                                                                                            
755. <action application="set" data="filename1=astpp.pbx.lua"/>                                                                                                                                                        
756. <action application="set" data="origination_rates=ID:2148457|CODE:^073.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426359|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13"/>                              
757. <action application="set" data="original_caller_id_name=0534740341"/>                                                                                                                                              
758. <action application="set" data="original_caller_id_number=0534740341"/>                                                                                                                                            
759. <action application="limit" data="db 196083 user_196083 200 "/>                                                                                                                                                    
760. <action application="limit" data="db 778509 user_778509 800 "/>                                                                                                                                                    
761. <action application="set" data="effective_caller_id_name=0534740341"/>                                                                                                                                            
762. <action application="set" data="effective_caller_id_number=0534740341"/>                                                                                                                                          
763. <action application="set" data="calltype=STANDARD"/>                                                                                                                                                              
764. <action application="set" data="termination_rates=ID:183|CODE:^0.*|DESTINATION:SA|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3"/>                                
765. <action application="set" data="trunk_id=5"/>                                                                                                                                                                      
766. <action application="set" data="provider_id=3"/>                                                                                                                                                                  
767. <action application="set" data="rate_flag=0"/>                                                                                                                                                                    
768. <action application="set" data="force_trunk_flag=2148457"/>                                                                                                                                                        
769. <action application="export" data="presence_data=trunk_id=5"/>                                                                                                                                                    
770. <action application="set" data="intcall=0"/>                                                                                                                                                                      
771. <action application="export" data="presence_data=x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN"/>                                                                                                                                                                    
772. <action application="bridge" data="[leg_timeout=0,absolute_codec_string=^^:PCMA:PCMU:G729]sofia/gateway/liquid_primary/0736001022;fs_path=sip:156.38.231.106:5060"/>                                              
773. </condition>                                                                                                                                                                                                      
774. </extension>                                                                                                                                                                                                      
775. </context>                                                                                                                                                                                                        
776. </section>                                                                                                                                                                                                        
777. </document>                                                                                                                                                                                                        
778. 2024-03-19 14:55:56.524192 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fed500f71b0 released.
779. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 parsing [default->0736001022] continue=false
780. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Regex (PASS) [0736001022] destination_number(0736001022) =~ /0736001022/ break=on-false
781. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(effective_destination_number=0736001022)
782. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup)
783. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
784. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(callstart=2024-03-19 14:55:56)
785. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(hangup_after_bridge=true)
786. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(continue_on_fail=TRUE)
787. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(account_id=109)
788. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(parent_id=13)
789. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(entity_id=0)
790. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(call_processed=internal)
791. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(call_direction=outbound)
792. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(accountname=default)
793. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(filename1=astpp.pbx.lua)
794. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(origination_rates=ID:2148457|CODE:^073.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426359|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13)                                                                                                                                                                                                        
795. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(original_caller_id_name=0534740341)
796. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(original_caller_id_number=0534740341)
797. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action limit(db 196083 user_196083 200 )
798. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action limit(db 778509 user_778509 800 )
799. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(effective_caller_id_name=0534740341)
800. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(effective_caller_id_number=0534740341)
801. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(calltype=STANDARD)
802. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(termination_rates=ID:183|CODE:^0.*|DESTINATION:SA|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3)                                                                                                                                                                                                          
803. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(trunk_id=5)
804. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(provider_id=3)
805. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(rate_flag=0)
806. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(force_trunk_flag=2148457)
807. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action export(presence_data=trunk_id=5)
808. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action set(intcall=0)
809. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action export(presence_data=x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN)                                                                                                                          
810. Dialplan: sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Action bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:PCMU:G729]sofia/gateway/liquid_primary/0736001022;fs_path=sip:156.38.231.106:5060)
811. 2024-03-19 14:55:56.524192 [DEBUG] switch_core_state_machine.c:286 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State Change CS_ROUTING -> CS_EXECUTE
812. 2024-03-19 14:55:56.524192 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State ROUTING going to sleep
813. 2024-03-19 14:55:56.524192 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Running State Change CS_EXECUTE (Cur 20 Tot 536011)
814. 2024-03-19 14:55:56.524192 [DEBUG] switch_core_state_machine.c:650 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) State EXECUTE
815. 2024-03-19 14:55:56.524192 [DEBUG] mod_sofia.c:198 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 SOFIA EXECUTE
816. 2024-03-19 14:55:56.524192 [DEBUG] switch_core_state_machine.c:328 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Standard EXECUTE
817. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(effective_destination_number=0736001022)
818. 2024-03-19 14:55:56.524192 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [effective_destination_number]=[0736001022]
819. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(bridge_pre_execute_bleg_app=sched_hangup)
820. 2024-03-19 14:55:56.524192 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [bridge_pre_execute_bleg_app]=[sched_hangup]
821. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
822. 2024-03-19 14:55:56.524192 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
823. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(callstart=2024-03-19 14:55:56)
824. 2024-03-19 14:55:56.524192 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [callstart]=[2024-03-19 14:55:56]
825. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(hangup_after_bridge=true)
826. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [hangup_after_bridge]=[true]
827. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(continue_on_fail=TRUE)
828. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [continue_on_fail]=[TRUE]
829. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(account_id=109)
830. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [account_id]=[109]
831. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(parent_id=13)
832. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [parent_id]=[13]
833. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(entity_id=0)
834. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [entity_id]=[0]
835. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(call_processed=internal)
836. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [call_processed]=[internal]
837. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(call_direction=outbound)
838. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [call_direction]=[outbound]
839. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(accountname=default)
840. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [accountname]=[default]
841. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(filename1=astpp.pbx.lua)
842. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [filename1]=[astpp.pbx.lua]
843. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(origination_rates=ID:2148457|CODE:^073.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426359|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13)                                                                                                                                                                                                                
844. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [origination_rates]=[ID:2148457|CODE:^073.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426359|CODE:^073.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13]                                                                                                                                                                
845. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(original_caller_id_name=0534740341)
846. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [original_caller_id_name]=[0534740341]
847. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(original_caller_id_number=0534740341)
848. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [original_caller_id_number]=[0534740341]
849. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 limit(db 196083 user_196083 200 )
850. 2024-03-19 14:55:56.544465 [DEBUG] switch_limit.c:126 incr called: 196083_user_196083 max:200, interval:0
851. 2024-03-19 14:55:56.544465 [DEBUG] mod_db.c:194 Usage for 196083_user_196083 is now 9/200
852. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 limit(db 778509 user_778509 800 )
853. 2024-03-19 14:55:56.544465 [DEBUG] switch_limit.c:126 incr called: 778509_user_778509 max:800, interval:0
854. 2024-03-19 14:55:56.544465 [DEBUG] mod_db.c:194 Usage for 778509_user_778509 is now 9/800
855. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(effective_caller_id_name=0534740341)
856. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [effective_caller_id_name]=[0534740341]
857. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(effective_caller_id_number=0534740341)
858. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [effective_caller_id_number]=[0534740341]
859. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(calltype=STANDARD)
860. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [calltype]=[STANDARD]
861. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(termination_rates=ID:183|CODE:^0.*|DESTINATION:SA|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3)
862. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [termination_rates]=[ID:183|CODE:^0.*|DESTINATION:SA|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:1|INITIALBLOCK:1|TRUNK:5|PROVIDER:3]                                                                                                                                                                  
863. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(trunk_id=5)
864. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [trunk_id]=[5]
865. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(provider_id=3)
866. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [provider_id]=[3]
867. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(rate_flag=0)
868. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [rate_flag]=[0]
869. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(force_trunk_flag=2148457)
870. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [force_trunk_flag]=[2148457]
871. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 export(presence_data=trunk_id=5)
872. 2024-03-19 14:55:56.544465 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [presence_data]=[trunk_id=5]
873. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 set(intcall=0)
874. 2024-03-19 14:55:56.544465 [DEBUG] mod_dptools.c:1548 SET sofia/default/0534740341@legalaidsa.nebular.co.za:5060 [intcall]=[0]
875. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 export(presence_data=x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN)                                                                                                                                  
876. 2024-03-19 14:55:56.544465 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [presence_data]=[x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN]                                                                                                                        
877. EXECUTE sofia/default/0534740341@legalaidsa.nebular.co.za:5060 bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:PCMU:G729]sofia/gateway/liquid_primary/0736001022;fs_path=sip:156.38.231.106:5060)
878. 2024-03-19 14:55:56.544465 [DEBUG] switch_channel.c:1250 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 EXPORTING[export_vars] [presence_data]=[x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN] to event                                                      
879. 2024-03-19 14:55:56.544465 [DEBUG] switch_channel.c:1250 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 EXPORTING[export_vars] [presence_data]=[x//13|||Legal Aid South Africa(196083)|||^073.* // SOUTH AFRICA - MTN - MOBILE // 0.44000 // trunk_id=0|||Liquid // ^0.* // SA // 0.00000 // trunk_id=5|||STD|||156.38.231.105|||0.29000 // ^073.* // D083-MTN] to event                                                      
880. 2024-03-19 14:55:56.544465 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
881. 2024-03-19 14:55:56.544465 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
882. 2024-03-19 14:55:56.544465 [NOTICE] switch_channel.c:1104 New Channel sofia/default/0736001022 [ca6c0aba-e600-11ee-8a2e-d17fbcf33421]
883. 2024-03-19 14:55:56.544465 [DEBUG] mod_sofia.c:4819 (sofia/default/0736001022) State Change CS_NEW -> CS_INIT
884. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0736001022) Running State Change CS_INIT (Cur 21 Tot 536012)
885. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0736001022) State INIT
886. 2024-03-19 14:55:56.544465 [DEBUG] mod_sofia.c:90 sofia/default/0736001022 SOFIA INIT
887. 2024-03-19 14:55:56.544465 [DEBUG] sofia_glue.c:1264 sip:156.38.231.106:5060 Setting proxy route to sofia/default/0736001022
888. 2024-03-19 14:55:56.544465 [DEBUG] sofia_glue.c:1295 sofia/default/0736001022 sending invite version: 1.6.20  64bit
889. Local SDP:                                                                                                                                                                                                        
890. v=0                                                                                                                                                                                                                
891. o=FreeSWITCH 1710839762 1710839763 IN IP4 156.38.231.107                                                                                                                                                          
892. s=FreeSWITCH                                                                                                                                                                                                      
893. c=IN IP4 156.38.231.107                                                                                                                                                                                            
894. t=0 0                                                                                                                                                                                                              
895. m=audio 20394 RTP/AVP 8 0 18 101                                                                                                                                                                                  
896. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
897. a=rtpmap:0 PCMU/8000                                                                                                                                                                                              
898. a=rtpmap:18 G729/8000                                                                                                                                                                                              
899. a=fmtp:18 annexb=no                                                                                                                                                                                                
900. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
901. a=fmtp:101 0-16                                                                                                                                                                                                    
902. a=ptime:20                                                                                                                                                                                                        
903. a=sendrecv                                                                                                                                                                                                        
904.  
905. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:40 sofia/default/0736001022 Standard INIT
906. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:48 (sofia/default/0736001022) State Change CS_INIT -> CS_ROUTING
907. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0736001022) State INIT going to sleep
908. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0736001022) Running State Change CS_ROUTING (Cur 21 Tot 536012)
909. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0736001022) State ROUTING
910. 2024-03-19 14:55:56.544465 [DEBUG] mod_sofia.c:143 sofia/default/0736001022 SOFIA ROUTING
911. 2024-03-19 14:55:56.544465 [DEBUG] switch_ivr_originate.c:67 (sofia/default/0736001022) State Change CS_ROUTING -> CS_CONSUME_MEDIA
912. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0736001022) State ROUTING going to sleep
913. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0736001022) Running State Change CS_CONSUME_MEDIA (Cur 21 Tot 536012)
914. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:662 (sofia/default/0736001022) State CONSUME_MEDIA
915. 2024-03-19 14:55:56.544465 [DEBUG] switch_core_state_machine.c:662 (sofia/default/0736001022) State CONSUME_MEDIA going to sleep
916. 2024-03-19 14:55:56.544465 [DEBUG] sofia.c:7084 Channel sofia/default/0736001022 entering state [calling][0]
917. 2024-03-19 14:55:57.844192 [DEBUG] sofia.c:7084 Channel sofia/default/0736001022 entering state [proceeding][183]
918. 2024-03-19 14:55:57.844192 [DEBUG] sofia.c:7094 Remote SDP:
919. v=0                                                                                                                                                                                                                
920. o=HuaweiSoftX3000 116961593864129 116961593864129 IN IP4 41.160.32.115                                                                                                                                            
921. s=-                                                                                                                                                                                                                
922. c=IN IP4 41.160.32.115                                                                                                                                                                                            
923. t=0 0                                                                                                                                                                                                              
924. m=audio 22230 RTP/AVP 8 101                                                                                                                                                                                        
925. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
926. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
927. a=fmtp:101 0-15                                                                                                                                                                                                    
928. a=ptime:20                                                                                                                                                                                                        
929.  
930. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
931. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
932. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
933. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
934. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
935. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/0736001022 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
936. 2024-03-19 14:55:57.844192 [DEBUG] switch_core_codec.c:111 sofia/default/0736001022 Original read codec set to PCMA:8
937. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
938. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:4767 sofia/default/0736001022 Set 2833 dtmf send payload to 101 recv payload to 101
939. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/0736001022] 156.38.231.107 port 20394 -> 41.160.32.115 port 22230 codec: 8 ms: 20
940. 2024-03-19 14:55:57.864165 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
941. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:7180 sofia/default/0736001022 Set 2833 dtmf send payload to 101
942. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:7187 sofia/default/0736001022 Set 2833 dtmf receive payload to 101
943. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:7210 sofia/default/0736001022 Set rtp dtmf delay to 40
944. 2024-03-19 14:55:57.864165 [NOTICE] sofia_media.c:92 Pre-Answer sofia/default/0736001022!
945. 2024-03-19 14:55:57.864165 [DEBUG] switch_channel.c:3474 (sofia/default/0736001022) Callstate Change DOWN -> EARLY
946. 2024-03-19 14:55:57.864165 [INFO] switch_ivr_originate.c:3654 Sending early media
947. 2024-03-19 14:55:57.864165 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/default/0534740341@legalaidsa.nebular.co.za:5060] 156.38.231.107 port 28222 -> 156.38.150.6 port 9720 codec: 8 ms: 20
948. 2024-03-19 14:55:57.886040 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
949. 2024-03-19 14:55:57.886040 [DEBUG] switch_core_media.c:7180 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Set 2833 dtmf send payload to 101
950. 2024-03-19 14:55:57.886040 [DEBUG] switch_core_media.c:7187 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Set 2833 dtmf receive payload to 101
951. 2024-03-19 14:55:57.886040 [DEBUG] switch_core_media.c:7210 sofia/default/0534740341@legalaidsa.nebular.co.za:5060 Set rtp dtmf delay to 40
952. 2024-03-19 14:55:57.886040 [DEBUG] mod_sofia.c:2364 Ring SDP:
953. v=0                                                                                                                                                                                                                
954. o=FreeSWITCH 1710831935 1710831936 IN IP4 156.38.231.107                                                                                                                                                          
955. s=FreeSWITCH                                                                                                                                                                                                      
956. c=IN IP4 156.38.231.107                                                                                                                                                                                            
957. t=0 0                                                                                                                                                                                                              
958. m=audio 28222 RTP/AVP 8 101                                                                                                                                                                                        
959. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
960. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
961. a=fmtp:101 0-16                                                                                                                                                                                                    
962. a=ptime:20                                                                                                                                                                                                        
963. a=sendrecv                                                                                                                                                                                                        
964.  
965. 2024-03-19 14:55:57.886040 [NOTICE] mod_sofia.c:2367 Pre-Answer sofia/default/0534740341@legalaidsa.nebular.co.za:5060!
966. 2024-03-19 14:55:57.886040 [DEBUG] switch_channel.c:3474 (sofia/default/0534740341@legalaidsa.nebular.co.za:5060) Callstate Change RINGING -> EARLY
967. 2024-03-19 14:55:57.886040 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/default/0736001022]
968. 2024-03-19 14:55:57.886040 [DEBUG] sofia.c:7084 Channel sofia/default/0534740341@legalaidsa.nebular.co.za:5060 entering state [early][183]
969. 2024-03-19 14:55:57.886040 [DEBUG] switch_ivr_bridge.c:1614 (sofia/default/0736001022) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
970. 2024-03-19 14:55:57.886040 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0736001022) Running State Change CS_EXCHANGE_MEDIA (Cur 21 Tot 536012)
971. 2024-03-19 14:55:57.886040 [DEBUG] switch_core_state_machine.c:653 (sofia/default/0736001022) State EXCHANGE_MEDIA
972. 2024-03-19 14:55:57.886040 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
973. 2024-03-19 14:55:57.924178 [DEBUG] sofia.c:7084 Channel sofia/default/0736001022 entering state [proceeding][180]
974. 2024-03-19 14:55:57.924178 [NOTICE] sofia.c:7192 Ring-Ready sofia/default/0736001022!
975. 2024-03-19 14:55:57.924178 [DEBUG] switch_channel.c:3346 (sofia/default/0736001022) Callstate Change EARLY -> RINGING
976. 2024-03-19 14:55:58.064315 [DEBUG] switch_ivr_bridge.c:546 sofia/default/0736001022 Bridge execute app sched_hangup(+6000 normal_clearing)
977. 2024-03-19 14:55:58.084190 [DEBUG] switch_ivr.c:623 sofia/default/0736001022 Command Execute sched_hangup(+6000 normal_clearing)
978. EXECUTE sofia/default/0736001022 sched_hangup(+6000 normal_clearing)
979. 2024-03-19 14:55:58.084190 [DEBUG] switch_scheduler.c:249 Added task 216772 switch_ivr_schedule_hangup (ca6c0aba-e600-11ee-8a2e-d17fbcf33421) to run at 1710866158
980. 2024-03-19 14:55:58.144185 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
981. 2024-03-19 14:55:58.144185 [INFO] switch_rtp.c:7268 Auto Changing audio port from 156.38.150.6:9720 to 156.38.231.105:9720
982. 2024-03-19 14:56:02.584158 [NOTICE] switch_channel.c:1104 New Channel sofia/default/0159626206@legalaidsa.nebular.co.za:5060 [ce06acd4-e600-11ee-8a34-d17fbcf33421]
983. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) Running State Change CS_NEW (Cur 22 Tot 536013)
984. 2024-03-19 14:56:02.584158 [DEBUG] sofia.c:9873 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 receiving invite from 156.38.231.106:5060 version: 1.6.20  64bit
985. 2024-03-19 14:56:02.584158 [DEBUG] sofia.c:9989 IP 156.38.231.106 Approved by acl "default[]". Access Granted.
986. 2024-03-19 14:56:02.584158 [DEBUG] sofia.c:7084 Channel sofia/default/0159626206@legalaidsa.nebular.co.za:5060 entering state [received][100]
987. 2024-03-19 14:56:02.584158 [DEBUG] sofia.c:7094 Remote SDP:
988. v=0                                                                                                                                                                                                                
989. o=3cxPS 392721072128 314807681025 IN IP4 156.38.150.6                                                                                                                                                              
990. s=3cxPS Audio call                                                                                                                                                                                                
991. c=IN IP4 156.38.150.6                                                                                                                                                                                              
992. t=0 0                                                                                                                                                                                                              
993. m=audio 9722 RTP/AVP 8 0 9 101                                                                                                                                                                                    
994. a=rtpmap:8 PCMA/8000                                                                                                                                                                                              
995. a=rtpmap:0 PCMU/8000                                                                                                                                                                                              
996. a=rtpmap:9 G722/8000                                                                                                                                                                                              
997. a=rtpmap:101 telephone-event/8000                                                                                                                                                                                  
998.  
999. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:60:8000:1]
1000. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
1001. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
1002. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
1003. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
1004. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:60:8000:1]
1005. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
1006. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
1007. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
1008. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
1009. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G729:18:8000:60:8000:1]
1010. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G729:18:8000:20:8000:1]
1011. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
1012. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
1013. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
1014. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/0159626206@legalaidsa.nebular.co.za:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
1015. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_codec.c:111 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 Original read codec set to PCMA:8
1016. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
1017. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_media.c:4767 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 Set 2833 dtmf send payload to 101 recv payload to 101
1018. 2024-03-19 14:56:02.584158 [DEBUG] sofia.c:7507 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State Change CS_NEW -> CS_INIT
1019. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:603 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State NEW
1020. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) Running State Change CS_INIT (Cur 22 Tot 536013)
1021. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State INIT
1022. 2024-03-19 14:56:02.584158 [DEBUG] mod_sofia.c:90 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 SOFIA INIT
1023. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:40 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 Standard INIT
1024. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:48 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State Change CS_INIT -> CS_ROUTING
1025. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:627 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State INIT going to sleep
1026. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:584 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) Running State Change CS_ROUTING (Cur 22 Tot 536013)
1027. 2024-03-19 14:56:02.584158 [DEBUG] switch_channel.c:2249 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) Callstate Change DOWN -> RINGING
1028. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:643 (sofia/default/0159626206@legalaidsa.nebular.co.za:5060) State ROUTING
1029. 2024-03-19 14:56:02.584158 [DEBUG] mod_sofia.c:143 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 SOFIA ROUTING
1030. 2024-03-19 14:56:02.584158 [DEBUG] switch_core_state_machine.c:236 sofia/default/0159626206@legalaidsa.nebular.co.za:5060 Standard ROUTING
1031. 2024-03-19 14:56:02.584158 [INFO] mod_dialplan_xml.c:637 Processing 0159626206 <0159626206>->0710575002 in context default
1032. 2024-03-19 14:56:02.584158 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fed500f71b0 Connected.
1033. 2024-03-19 14:56:02.584158 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
1034. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
1035. 2024-03-19 14:56:02.604237 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] blind_flag: 0
1036. 2024-03-19 14:56:02.604237 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Dialed number : 0710575002
1037. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '0710575002' limit 1
1038. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '0710575002' AND status=0 limit 1
1039. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '0710575002' and status=0 LIMIT 1                                                                                                                                                                                                          
1040. 2024-03-19 14:56:02.604237 [WARNING] switch_cpp.cpp:1365 [ASTPP] [FAXER] Custom Caller ID
1041. 2024-03-19 14:56:02.604237 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Caller Id name / number  : 0159626206 / 0159626206
1042. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0710575002" LIMIT 1                                                                                                                                                              
1043. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0710575002"  AND domains.domain="legalaidsa.nebular.co.za" limit 1                                                                                      
1044. 2024-03-19 14:56:02.604237 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] Call direction : outbound
1045. 2024-03-19 14:56:02.604237 [INFO] switch_cpp.cpp:1365 [ASTPP] [Accountcode : 196083]
1046. 2024-03-19 14:56:02.604237 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "196083" AND deleted = 0 limit 1
1047. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^0710575002.*' OR blocked_patterns = '^071057500.*' OR blocked_patterns = '^07105750.*' OR blocked_patterns = '^0710575.*' OR blocked_patterns = '^071057.*' OR blocked_patterns = '^07105.*' OR blocked_patterns = '^0710.*' OR blocked_patterns = '^071.*' OR blocked_patterns = '^07.*' OR blocked_patterns = '^0.*' OR blocked_patterns ='--') AND accountid = 109 limit 1                                                                                                                      
1048. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="0710575002" AND (accountid = 0 OR status = 1) LIMIT 1
1049. 2024-03-19 14:56:02.624305 [NOTICE] switch_cpp.cpp:1365 [ASTPP] Localization Id: 3
1050. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate,dst_base_cid FROM localization WHERE id = 3 AND status=0 limit 1                                                                                                                                                                                                  
1051. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0710575002
1052. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"27/0,00/99".....0710575002
1053. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^0710575002.*' OR patterns = '^071057500.*' OR patterns = '^07105750.*' OR patterns = '^0710575.*' OR patterns = '^071057.*' OR patterns = '^07105.*' OR patterns = '^0710.*' OR patterns = '^071.*' OR patterns = '^07.*' OR patterns = '^0.*' OR patterns ='--') AND accountid = 109 ORDER BY LENGTH(PKGPTR.patterns) DESC                                                        
1054. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="0710575002" AND A.accountid = '109' limit 1                                                                                                                                                                        
1055. 2024-03-19 14:56:02.624305 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 0710575002
1056. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="0710575002" LIMIT 1                                                                                                                                                              
1057. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="0710575002"  AND domains.domain="legalaidsa.nebular.co.za" limit 1                                                                                      
1058. 2024-03-19 14:56:02.624305 [INFO] switch_cpp.cpp:1365 [ASTPP] [Dialplan] New Call Direction : outbound
1059. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '0710575002' OR number = '071057500' OR number = '07105750' OR number = '0710575' OR number = '071057' OR number = '07105' OR number = '0710' OR number = '071' OR number = '07' OR number = '0' OR number ='--') OR (number = '0710575002*' OR number = '071057500*' OR number = '07105750*' OR number = '0710575*' OR number = '071057*' OR number = '07105*' OR number = '0710*' OR number = '071*' OR number = '07*' OR number = '0*' OR number ='--') OR (number = '0159626206' OR number = '015962620' OR number = '01596262' OR number = '0159626' OR number = '015962' OR number = '01596' OR number = '0159' OR number = '015' OR number = '01' OR number = '0' OR number ='--') OR (number = '0159626206*' OR number = '015962620*' OR number = '01596262*' OR number = '0159626*' OR number = '015962*' OR number = '01596*' OR number = '0159*' OR number = '015*' OR number = '01*' OR number = '0*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC                                                                                          
1060. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] Call Barring Status : -1
1061. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '0710575002' OR routing_prefix = '071057500' OR routing_prefix = '07105750' OR routing_prefix = '0710575' OR routing_prefix = '071057' OR routing_prefix = '07105' OR routing_prefix = '0710' OR routing_prefix = '071' OR routing_prefix = '07' OR routing_prefix = '0' OR routing_prefix ='--') AND status = 0 and reseller_id = 13 limit 1                                                                                                                    
1062. 2024-03-19 14:56:02.624305 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Get Destination Number (0710575002)!!!!
1063. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Ported Number :27710575002
1064. 2024-03-19 14:56:02.624305 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] Query :SELECT rnoroute FROM ported_number WHERE dnfrom ='27710575002' limit 1
1065. 2024-03-19 14:56:02.624305 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [PORTED_NUMBER] After Append Ported Number : (0710575002)!!!!
1066. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Account Information ===================
1067. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 109
1068. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : 196083
1069. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 11176.1935
1070. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
1071. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 93
1072. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] CID Pool : 0
1073. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
1074. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1075. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1076. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1077. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1078. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1079. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1080. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1081. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1082. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1083. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1084. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1085. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_LOCALIZATION] Query :"D871/,D874/,D912/".....0159626206
1086. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 93 AND status = 0
1087. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] call_direction :outbound
1088. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 93 AND status = 0
1089. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^0710575002.*' OR pattern = '^071057500.*' OR pattern = '^07105750.*' OR pattern = '^0710575.*' OR pattern = '^071057.*' OR pattern = '^07105.*' OR pattern = '^0710.*' OR pattern = '^071.*' OR pattern = '^07.*' OR pattern = '^0.*' OR pattern ='--') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 93 OR accountid=109)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC,effective_date DESC LIMIT 1                                                                                      
1090. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP]  Call Direction : outbound
1091. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
1092. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 2148435
1093. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
1094. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
1095. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 0.44000
1096. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Comment : SOUTH AFRICA - MTN - MOBILE
1097. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Country Id : 0
1098. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 109
1099. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Trunk ID: 0
1100. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Routing type:
1101. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
1102. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Your11176.1935 balance Accountid 109 !!!
1103. 2024-03-19 14:56:02.644150 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
1104. 2024-03-19 14:56:02.644150 [NOTICE] switch_cpp.cpp:1365 [ASTPP] FINDING LIMIT FOR RESELLER: 13
1105. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "13" AND deleted = 0 limit 1
1106. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^0710575002.*' OR blocked_patterns = '^071057500.*' OR blocked_patterns = '^07105750.*' OR blocked_patterns = '^0710575.*' OR blocked_patterns = '^071057.*' OR blocked_patterns = '^07105.*' OR blocked_patterns = '^0710.*' OR blocked_patterns = '^071.*' OR blocked_patterns = '^07.*' OR blocked_patterns = '^0.*' OR blocked_patterns ='--') AND accountid = 13 limit 1                                                                                                                      
1107. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Reseller Information ===================
1108. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] User id : 13
1109. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Account code : 778509
1110. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Balance : 10289.9683
1111. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
1112. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Ratecard id : 83
1113. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 83 AND status = 0
1114. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] call_direction :outbound
1115. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 83 AND status = 0
1116. 2024-03-19 14:56:02.644150 [DEBUG] switch_cpp.cpp:1365 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^0710575002.*' OR pattern = '^071057500.*' OR pattern = '^07105750.*' OR pattern = '^0710575.*' OR pattern = '^071057.*' OR pattern = '^07105.*' OR pattern = '^0710.*' OR pattern = '^071.*' OR pattern = '^07.*' OR pattern = '^0.*' OR pattern ='--') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 83 OR accountid=13)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC,effective_date DESC LIMIT 1                                                                                      
1117. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP]  Call Direction : outbound
1118. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] =============== Rates Information ===================
1119. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ID : 1426337
1120. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Connectcost : 0.00000
1121. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Includedseconds : 0
1122. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Cost : 0.29000
1123. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Comment : D083-MTN
1124. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Country Id : 0
1125. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Accid : 13
1126. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Trunk ID: 0
1127. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Routing type:
1128. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ================================================================
1129. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Your10289.9683 balance Accountid 13 !!!
1130. 2024-03-19 14:56:02.644150 [NOTICE] switch_cpp.cpp:1365 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
1131. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Reseller xml_user_rates : ID:2148435|CODE:^0710.*|DESTINATION:SOUTH AFRICA - MTN - MOBILE|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.44000|INC:1|INITIALBLOCK:1|RATEGROUP:93|MARKUP:0|CI:0|ACCID:109||ID:1426337|CODE:^0710.*|DESTINATION:D083-MTN|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.29000|INC:1|INITIALBLOCK:1|RATEGROUP:83|MARKUP:0|CI:0|ACCID:13                                                                                                                                                                                                            
1132. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] ========================================================
1133. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Lossless Routing Status : 1
1134. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] Call Max Length Duration : 100 minutes
1135. 2024-03-19 14:56:02.644150 [INFO] switch_cpp.cpp:1365 [ASTPP] [DIALPLAN] User Rate ID : 2148435
1136.