1. 2021-12-01 05:13:25.373566 98.97% [ERR] switch_stun.c:900 STUN Failed! [Timeout]
2. 2021-12-01 05:13:25.373566 98.97% [ERR] switch_xml.c:175 stun-set failed.
3. 2021-12-01 05:13:30.393571 98.93% [ERR] switch_stun.c:900 STUN Failed! [Timeout]
4. 2021-12-01 05:13:30.393571 98.93% [ERR] switch_xml.c:175 stun-set failed.
5. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1115 Write lock interface 'sofia' to wait for existing references.
6. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1123 Deleting Endpoint 'sofia'
7. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1115 Write lock interface 'rtp' to wait for existing references.
8. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1123 Deleting Endpoint 'rtp'
9. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1228 Deleting Application 'sofia_sla'
10. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1230 Write lock interface 'sofia_sla' to wait for existing references.
11. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1228 Deleting Application 'sofia_stir_shaken_vs'
12. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1230 Write lock interface 'sofia_stir_shaken_vs' to wait for existing references.
13. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia'
14. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia' to wait for existing references.
15. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_gateway_data'
16. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_gateway_data' to wait for existing references.
17. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_username_of'
18. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_username_of' to wait for existing references.
19. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_contact'
20. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_contact' to wait for existing references.
21. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_count_reg'
22. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_count_reg' to wait for existing references.
23. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_dig'
24. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_dig' to wait for existing references.
25. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_presence_data'
26. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia_presence_data' to wait for existing references.
27. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1315 Deleting API Function 'sofia.status'
28. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1317 Write lock interface 'sofia.status' to wait for existing references.
29. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1315 Deleting API Function 'sofia.status.info'
30. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1317 Write lock interface 'sofia.status.info' to wait for existing references.
31. 2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1535 Write lock interface 'sip' to wait for existing references.
32. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1544 Deleting Chat interface 'sip'
33. 2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1586 Deleting Management interface 'mod_sofia' OID[.1.3.6.1.4.1.27880.1001]
34. 2021-12-01 05:13:30.413571 98.93% [CONSOLE] switch_loadable_module.c:2349 Stopping: mod_sofia
35. 2021-12-01 05:13:30.433559 98.93% [INFO] switch_time.c:1430 Timezone reloaded 1750 definitions
36. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::notify_refer
37. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::notify_watched_header
38. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::unregister
39. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::profile_start
40. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::reinvite
41. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::replaced
42. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::transferor
43. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::transferee
44. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::error
45. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::intercepted
46. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_state
47. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::sip_user_state
48. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_delete
49. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::expire
50. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register_attempt
51. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register_failure
52. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::pre_register
53. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register
54. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_add
55. 2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::bye_response
56. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_IN
57. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_OUT
58. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_PROBE
59. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:MESSAGE_WAITING
60. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:ROSTER
61. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:CONFERENCE_DATA
62. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:TRAP
63. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:NOTIFY
64. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PHONE_FEATURE
65. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:SEND_MESSAGE
66. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:SEND_INFO
67. 2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:CUSTOM
68. 2021-12-01 05:13:30.433559 98.93% [CONSOLE] sofia_presence.c:1664 Event Thread Ended
69. 2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia.c:3504 Waiting for worker thread
70. 2021-12-01 05:13:30.833566 98.93% [INFO] switch_core_sqldb.c:1876 sofia:default Destroying SQL queue.
71. 2021-12-01 05:13:30.833566 98.93% [DEBUG] sofia_reg.c:324 Removing gateway external_without_reg::ModulusOutgoing from hash.
72. 2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia_reg.c:338 Deleted gateway ModulusOutgoing
73. 2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia.c:3504 Waiting for worker thread
74. 2021-12-01 05:13:30.833566 98.93% [INFO] switch_core_sqldb.c:1876 sofia:external_without_reg Destroying SQL queue.
75. 2021-12-01 05:13:31.013565 98.87% [DEBUG] sofia_reg.c:324 Removing gateway external_sip_interbi::Interbit from hash.
76. 2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia_reg.c:137 UN-Registering Interbit
77. 2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia_reg.c:338 Deleted gateway Interbit
78. 2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia.c:3504 Waiting for worker thread
79. 2021-12-01 05:13:31.013565 98.87% [INFO] switch_core_sqldb.c:1876 sofia:external_sip_interbi Destroying SQL queue.
80. 2021-12-01 05:13:31.033564 98.87% [INFO] switch_core_sqldb.c:1827 sofia:default Stopping SQL thread.
81. 2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3576 Write lock default
82. 2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3589 Write unlock default
83. 2021-12-01 05:13:31.033564 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_without_reg Stopping SQL thread.
84. 2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3576 Write lock external_without_reg
85. 2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3589 Write unlock external_without_reg
86. 2021-12-01 05:13:31.193564 98.87% [DEBUG] sofia_reg.c:324 Removing gateway external_sip::ModulusIncoming from hash.
87. 2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia_reg.c:137 UN-Registering ModulusIncoming
88. 2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia_reg.c:338 Deleted gateway ModulusIncoming
89. 2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia.c:3504 Waiting for worker thread
90. 2021-12-01 05:13:31.193564 98.87% [INFO] switch_core_sqldb.c:1876 sofia:external_sip Destroying SQL queue.
91. 2021-12-01 05:13:31.213558 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_sip_interbi Stopping SQL thread.
92. 2021-12-01 05:13:31.213558 98.87% [DEBUG] sofia.c:3576 Write lock external_sip_interbi
93. 2021-12-01 05:13:31.213558 98.87% [DEBUG] sofia.c:3589 Write unlock external_sip_interbi
94. 2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_sip Stopping SQL thread.
95. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3576 Write lock external_sip
96. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3589 Write unlock external_sip
97. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:2308 MSG Thread Ended
98. 2021-12-01 05:13:31.393558 98.87% [CONSOLE] switch_loadable_module.c:2369 mod_sofia unloaded.
99. 2021-12-01 05:13:31.393558 98.87% [INFO] mod_sofia.c:6682 Starting initial message thread.
100. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
101. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6060]
102. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
103. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
104. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhonesystem]
105. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
106. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
107. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
108. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
109. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
110. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
111. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
112. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
113. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
114. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
115. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
116. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [false]
117. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
118. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [300]
119. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
120. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
121. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [true]
122. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [true]
123. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
124. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
125. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
126. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
127. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
128. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,PCMU]
129. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,PCMU]
130. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
131. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-capture [no]
132. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 forward-unsolicited-mwi-notify [false]
133. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 context [default]
134. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rfc2833-pt [101]
135. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timer-name [soft]
136. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 hold-music [local_stream://moh]
137. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manage-presence [true]
138. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 presence-hosts [172.16.0.30,172.16.0.30]
139. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 presence-privacy [false]
140. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-negotiation [generous]
141. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-all-packets [false]
142. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
143. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
144. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-hold-timeout-sec [1800]
145. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5332 rtp-hold-timeout-sec deprecated use media_hold_timeout variable.
146. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 challenge-realm [auto_from]
147. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 nonce-ttl [60]
148. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 pass-callee-id [false]
149. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf_type [rfc2833]
150. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
151. 2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile default [sofia_reg_default]
152. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
153. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for default
154. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6080]
155. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
156. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
157. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhonesystem]
158. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
159. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
160. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
161. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
162. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
163. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
164. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
165. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
166. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
167. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
168. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
169. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
170. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
171. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
172. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
173. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
174. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
175. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
176. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
177. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
178. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
179. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [false]
180. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
181. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,OPUS,G729]
182. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,OPUS,G729]
183. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
184. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
185. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
186. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
187. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
188. 2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_sip [sofia_reg_external_sip]
189. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
190. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_sip
191. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6090]
192. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
193. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
194. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [Allnetworks]
195. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
196. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
197. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
198. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
199. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
200. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
201. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
202. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
203. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
204. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
205. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
206. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
207. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
208. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
209. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
210. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
211. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
212. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
213. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
214. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
215. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
216. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
217. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
218. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,OPUS,G729]
219. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,OPUS,G729]
220. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
221. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
222. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
223. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
224. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
225. 2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_without_reg [sofia_reg_external_without_reg]
226. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
227. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6085]
228. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_without_reg
229. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
230. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
231. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhoneSystem 16.0.8.9]
232. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
233. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
234. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
235. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
236. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
237. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
238. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
239. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
240. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
241. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
242. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
243. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
244. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
245. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
246. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
247. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
248. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
249. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
250. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
251. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
252. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
253. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
254. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
255. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,G729]
256. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,G729]
257. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
258. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
259. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
260. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
261. 2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
262. 2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_sip_interbi [sofia_reg_external_sip_interbi]
263. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_sip_interbi
264. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for default
265. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for default
266. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for default
267. 2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:default Starting SQL thread.
268. 2021-12-01 05:13:31.393558 98.87% [DEBUG] mod_sofia.c:6698 Waiting for profiles to start
269. 2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:2290 MSG Thread 0 Started
270. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_without_reg
271. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_without_reg
272. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_without_reg
273. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for default
274. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for default
275. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_sip_interbi
276. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_sip_interbi
277. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_sip_interbi
278. 2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_without_reg Starting SQL thread.
279. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_sip
280. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_sip
281. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_sip
282. 2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_sip_interbi Starting SQL thread.
283. 2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_sip Starting SQL thread.
284. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_without_reg
285. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_without_reg
286. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_sip_interbi
287. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_sip_interbi
288. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_sip
289. 2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_sip
290. 2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'ModulusOutgoing' to profile 'external_without_reg'
291. 2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'Interbit' to profile 'external_sip_interbi'
292. 2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'ModulusIncoming' to profile 'external_sip'
293. 2021-12-01 05:13:32.413568 99.43% [NOTICE] sofia_reg.c:459 Registering Interbit
294. 2021-12-01 05:13:32.413568 99.43% [NOTICE] sofia_reg.c:459 Registering ModulusIncoming
295. 2021-12-01 05:13:32.573568 99.43% [DEBUG] sofia_reg.c:2665 Changing expire time to 105 by request of proxy sip:voips.modulus.gr:5060
296. 2021-12-01 05:13:32.893565 99.60% [CONSOLE] switch_loadable_module.c:1768 Successfully Loaded [mod_sofia]
297. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:172 Adding Endpoint 'sofia'
298. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:172 Adding Endpoint 'rtp'
299. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:329 Adding Application 'sofia_sla'
300. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:329 Adding Application 'sofia_stir_shaken_vs'
301. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia'
302. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_gateway_data'
303. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_username_of'
304. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_contact'
305. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_count_reg'
306. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_dig'
307. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_presence_data'
308. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:419 Adding JSON API Function 'sofia.status'
309. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:419 Adding JSON API Function 'sofia.status.info'
310. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:621 Adding Chat interface 'sip'
311. 2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:681 Adding Management interface 'mod_sofia' OID[.1.3.6.1.4.1.27880.1001]
312. 2021-12-01 05:13:49.613564 99.67% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [7772615170@onvoip.allnetworks.gr] from ip 194.219.29.89
313. 2021-12-01 05:13:49.733561 99.67% [CONSOLE] mod_voicemail.c:4065 Event Thread Started
314. 2021-12-01 05:13:49.733561 99.67% [CONSOLE] sofia_presence.c:1620 Event Thread Started
315. 2021-12-01 05:14:18.053566 99.03% [NOTICE] switch_channel.c:1123 New Channel sofia/external_sip_interbi/+306974108809@46.4.60.4 [93438172-78b0-4132-9a55-d451387ece6e]
316. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:581 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_NEW (Cur 1 Tot 1)
317. 2021-12-01 05:14:18.053566 99.03% [INFO] sofia.c:10462 sofia/external_sip_interbi/+306974108809@46.4.60.4 receiving invite from 46.4.60.4:5070 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 601627ea-cd08-123a-f4aa-6c626da7bbd3
318. 2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 46.4.60.4:0.
319. 2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:10585 IP 46.4.60.4 Approved by acl "default[]". Access Granted.
320. 2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:7499 Channel sofia/external_sip_interbi/+306974108809@46.4.60.4 entering state [received][100]
321. 2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:7509 Remote SDP:
322. v=0
323. o=FreeSWITCH 1638316494 1638316495 IN IP4 46.4.60.4
324. s=FreeSWITCH
325. c=IN IP4 46.4.60.4
326. t=0 0
327. m=audio 19164 RTP/AVP 8 18 101 13
328. a=rtpmap:8 PCMA/8000
329. a=rtpmap:18 G729/8000
330. a=rtpmap:101 telephone-event/8000
331. a=fmtp:101 0-16
332. a=ptime:20
333.  
334. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
335. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
336. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
337. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
338. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
339. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
340. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
341. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:3870 Set Codec sofia/external_sip_interbi/+306974108809@46.4.60.4 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
342. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_codec.c:111 sofia/external_sip_interbi/+306974108809@46.4.60.4 Original read codec set to PCMA:8
343. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
344. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5973 sofia/external_sip_interbi/+306974108809@46.4.60.4 Set 2833 dtmf send payload to 101 recv payload to 101
345. 2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:7933 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State Change CS_NEW -> CS_INIT
346. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:600 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State NEW
347. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:581 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_INIT (Cur 1 Tot 1)
348. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:624 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State INIT
349. 2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:97 sofia/external_sip_interbi/+306974108809@46.4.60.4 SOFIA INIT
350. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:40 sofia/external_sip_interbi/+306974108809@46.4.60.4 Standard INIT
351. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:48 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State Change CS_INIT -> CS_ROUTING
352. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:624 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State INIT going to sleep
353. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:581 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_ROUTING (Cur 1 Tot 1)
354. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_channel.c:2380 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Callstate Change DOWN -> RINGING
355. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:640 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State ROUTING
356. 2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:158 sofia/external_sip_interbi/+306974108809@46.4.60.4 SOFIA ROUTING
357. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:230 sofia/external_sip_interbi/+306974108809@46.4.60.4 Standard ROUTING
358. 2021-12-01 05:14:18.053566 99.03% [INFO] mod_dialplan_xml.c:639 Processing +306974108809 <+306974108809>->HNR-90057 in context default
359. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
360. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
361. 2021-12-01 05:14:18.053566 99.03% [ERR] mod_lua.cpp:202 /usr/share/freeswitch/scripts/astpp/scripts/astpp.dialplan.lua: corrupted precompiled chunk
362. stack traceback:
363.         [C]: in function 'dofile'
364.         ./astpp/astpp_deb9.lua:87: in main chunk
365. 2021-12-01 05:14:18.053566 99.03% [ERR] mod_lua.cpp:270 LUA script parse/execute error!
366. 2021-12-01 05:14:18.053566 99.03% [WARNING] mod_dialplan_xml.c:669 Context default not found
367. 2021-12-01 05:14:18.053566 99.03% [INFO] switch_core_state_machine.c:306 No Route, Aborting
368. 2021-12-01 05:14:18.053566 99.03% [NOTICE] switch_core_state_machine.c:307 Hangup sofia/external_sip_interbi/+306974108809@46.4.60.4 [CS_ROUTING] [NO_ROUTE_DESTINATION]
369. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:640 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State ROUTING going to sleep
370. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:581 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_HANGUP (Cur 1 Tot 1)
371. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:844 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Callstate Change RINGING -> HANGUP
372. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:846 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State HANGUP
373. 2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:468 Channel sofia/external_sip_interbi/+306974108809@46.4.60.4 hanging up, cause: NO_ROUTE_DESTINATION
374. 2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 404
375. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:59 sofia/external_sip_interbi/+306974108809@46.4.60.4 Standard HANGUP, cause: NO_ROUTE_DESTINATION
376. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:846 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State HANGUP going to sleep
377. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:616 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State Change CS_HANGUP -> CS_REPORTING
378. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:581 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_REPORTING (Cur 1 Tot 1)
379. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:932 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State REPORTING
380. 2021-12-01 05:14:18.053566 99.03% [INFO] mod_json_cdr.c:271 Process [93438172-78b0-4132-9a55-d451387ece6e.cdr.json]
381. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:168 sofia/external_sip_interbi/+306974108809@46.4.60.4 Standard REPORTING, cause: NO_ROUTE_DESTINATION
382. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:932 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State REPORTING going to sleep
383. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:607 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State Change CS_REPORTING -> CS_DESTROY
384. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_session.c:1753 Session 1 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Locked, Waiting on external entities
385. 2021-12-01 05:14:18.053566 99.03% [NOTICE] switch_core_session.c:1771 Session 1 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Ended
386. 2021-12-01 05:14:18.053566 99.03% [NOTICE] switch_core_session.c:1775 Close Channel sofia/external_sip_interbi/+306974108809@46.4.60.4 [CS_DESTROY]
387. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:735 (sofia/external_sip_interbi/+306974108809@46.4.60.4) Running State Change CS_DESTROY (Cur 0 Tot 1)
388. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:745 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State DESTROY
389. 2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:379 sofia/external_sip_interbi/+306974108809@46.4.60.4 SOFIA DESTROY
390. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:175 sofia/external_sip_interbi/+306974108809@46.4.60.4 Standard DESTROY
391. 2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_state_machine.c:745 (sofia/external_sip_interbi/+306974108809@46.4.60.4) State DESTROY going to sleep
392. 2021-12-01 05:14:33.453559 99.73% [DEBUG] sofia_reg.c:2665 Changing expire time to 90 by request of proxy sip:voips.modulus.gr:5060
393. 2021-12-01 05:15:27.453575 99.00% [DEBUG] sofia_reg.c:2665 Changing expire time to 98 by request of proxy sip:voips.modulus.gr:5060
394.