2021-12-01 05:13:25.373566 98.97% [ERR] switch_stun.c:900 STUN Failed! [Timeout]
2021-12-01 05:13:25.373566 98.97% [ERR] switch_xml.c:175 stun-set failed.
2021-12-01 05:13:30.393571 98.93% [ERR] switch_stun.c:900 STUN Failed! [Timeout]
2021-12-01 05:13:30.393571 98.93% [ERR] switch_xml.c:175 stun-set failed.
2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1115 Write lock interface 'sofia' to wait for existing references.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1123 Deleting Endpoint 'sofia'
2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1115 Write lock interface 'rtp' to wait for existing references.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1123 Deleting Endpoint 'rtp'
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1228 Deleting Application 'sofia_sla'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1228 Deleting Application 'sofia_stir_shaken_vs'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia'
2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1285 Write lock interface 'sofia' to wait for existing references.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_gateway_data'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_username_of'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_contact'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_count_reg'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_dig'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1283 Deleting API Function 'sofia_presence_data'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1315 Deleting API Function 'sofia.status'
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.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1315 Deleting API Function 'sofia.status.info'
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.
2021-12-01 05:13:30.413571 98.93% [DEBUG] switch_loadable_module.c:1535 Write lock interface 'sip' to wait for existing references.
2021-12-01 05:13:30.413571 98.93% [NOTICE] switch_loadable_module.c:1544 Deleting Chat interface 'sip'
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]
2021-12-01 05:13:30.413571 98.93% [CONSOLE] switch_loadable_module.c:2349 Stopping: mod_sofia
2021-12-01 05:13:30.433559 98.93% [INFO] switch_time.c:1430 Timezone reloaded 1750 definitions
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::notify_refer
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
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::unregister
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::profile_start
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::reinvite
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::replaced
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::transferor
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::transferee
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::error
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::intercepted
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_state
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
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_delete
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::expire
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register_attempt
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register_failure
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::pre_register
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::register
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::gateway_add
2021-12-01 05:13:30.433559 98.93% [NOTICE] switch_event.c:467 Subclass reservation deleted for mod_sofia.c:sofia::bye_response
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_IN
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_OUT
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PRESENCE_PROBE
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:MESSAGE_WAITING
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:ROSTER
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:CONFERENCE_DATA
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:TRAP
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:NOTIFY
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:PHONE_FEATURE
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:SEND_MESSAGE
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:SEND_INFO
2021-12-01 05:13:30.433559 98.93% [DEBUG] switch_event.c:2138 Event Binding deleted for mod_sofia:CUSTOM
2021-12-01 05:13:30.433559 98.93% [CONSOLE] sofia_presence.c:1664 Event Thread Ended
2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia.c:3504 Waiting for worker thread
2021-12-01 05:13:30.833566 98.93% [INFO] switch_core_sqldb.c:1876 sofia:default Destroying SQL queue.
2021-12-01 05:13:30.833566 98.93% [DEBUG] sofia_reg.c:324 Removing gateway external_without_reg::ModulusOutgoing from hash.
2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia_reg.c:338 Deleted gateway ModulusOutgoing
2021-12-01 05:13:30.833566 98.93% [NOTICE] sofia.c:3504 Waiting for worker thread
2021-12-01 05:13:30.833566 98.93% [INFO] switch_core_sqldb.c:1876 sofia:external_without_reg Destroying SQL queue.
2021-12-01 05:13:31.013565 98.87% [DEBUG] sofia_reg.c:324 Removing gateway external_sip_interbi::Interbit from hash.
2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia_reg.c:137 UN-Registering Interbit
2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia_reg.c:338 Deleted gateway Interbit
2021-12-01 05:13:31.013565 98.87% [NOTICE] sofia.c:3504 Waiting for worker thread
2021-12-01 05:13:31.013565 98.87% [INFO] switch_core_sqldb.c:1876 sofia:external_sip_interbi Destroying SQL queue.
2021-12-01 05:13:31.033564 98.87% [INFO] switch_core_sqldb.c:1827 sofia:default Stopping SQL thread.
2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3576 Write lock default
2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3589 Write unlock default
2021-12-01 05:13:31.033564 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_without_reg Stopping SQL thread.
2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3576 Write lock external_without_reg
2021-12-01 05:13:31.033564 98.87% [DEBUG] sofia.c:3589 Write unlock external_without_reg
2021-12-01 05:13:31.193564 98.87% [DEBUG] sofia_reg.c:324 Removing gateway external_sip::ModulusIncoming from hash.
2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia_reg.c:137 UN-Registering ModulusIncoming
2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia_reg.c:338 Deleted gateway ModulusIncoming
2021-12-01 05:13:31.193564 98.87% [NOTICE] sofia.c:3504 Waiting for worker thread
2021-12-01 05:13:31.193564 98.87% [INFO] switch_core_sqldb.c:1876 sofia:external_sip Destroying SQL queue.
2021-12-01 05:13:31.213558 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_sip_interbi Stopping SQL thread.
2021-12-01 05:13:31.213558 98.87% [DEBUG] sofia.c:3576 Write lock external_sip_interbi
2021-12-01 05:13:31.213558 98.87% [DEBUG] sofia.c:3589 Write unlock external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1827 sofia:external_sip Stopping SQL thread.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3576 Write lock external_sip
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3589 Write unlock external_sip
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:2308 MSG Thread Ended
2021-12-01 05:13:31.393558 98.87% [CONSOLE] switch_loadable_module.c:2369 mod_sofia unloaded.
2021-12-01 05:13:31.393558 98.87% [INFO] mod_sofia.c:6682 Starting initial message thread.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6060]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhonesystem]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [300]
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,PCMU]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,PCMU]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-capture [no]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 forward-unsolicited-mwi-notify [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 context [default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rfc2833-pt [101]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timer-name [soft]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 hold-music [local_stream://moh]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manage-presence [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 presence-hosts [172.16.0.30,172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 presence-privacy [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-negotiation [generous]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-all-packets [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-hold-timeout-sec [1800]
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5332 rtp-hold-timeout-sec deprecated use media_hold_timeout variable.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 challenge-realm [auto_from]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 nonce-ttl [60]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 pass-callee-id [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf_type [rfc2833]
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile default [sofia_reg_default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for default
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6080]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhonesystem]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,OPUS,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,OPUS,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_sip [sofia_reg_external_sip]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_sip
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6090]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [Allnetworks]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,OPUS,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,OPUS,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_without_reg [sofia_reg_external_without_reg]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-port [6085]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-ip [172.16.0.30]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dialplan [XML]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 user-agent-string [3CXPhoneSystem 16.0.8.9]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 debug [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 sip-trace [no]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 tls [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-reg-force-matching-username [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transcoding [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 all-reg-options-ping [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 unregister-on-options-fail [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 log-auth-failures [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 status [0]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-bypass-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-proxy-media [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 disable-transfer [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-100rel [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 rtp-timeout-sec [60]
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:5325 rtp-timeout-sec deprecated use media_timeout variable.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 dtmf-duration [2000]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 manual-redirect [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 aggressive-nat-detection [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 enable-timer [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 minimum-session-expires [120]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 session-timeout-pt [1800]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 auth-calls [true]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 apply-inbound-acl [default]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-codec-prefs [PCMA,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 outbound-codec-prefs [PCMA,G729]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 inbound-late-negotiation [false]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-sip-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:4720 ext-rtp-ip [94.130.242.106]
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6184 Setting nonce TTL to 60 seconds
2021-12-01 05:13:31.393558 98.87% [INFO] sofia.c:6189 Setting MAX Auth Validity to 0 Attempts
2021-12-01 05:13:31.393558 98.87% [NOTICE] sofia.c:6356 Started Profile external_sip_interbi [sofia_reg_external_sip_interbi]
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3156 Creating agent for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for default
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for default
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for default
2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:default Starting SQL thread.
2021-12-01 05:13:31.393558 98.87% [DEBUG] mod_sofia.c:6698 Waiting for profiles to start
2021-12-01 05:13:31.393558 98.87% [WARNING] sofia.c:2290 MSG Thread 0 Started
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for default
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for default
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_without_reg Starting SQL thread.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3319 Created agent for external_sip
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3369 Set params for external_sip
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3416 Activated db for external_sip
2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_sip_interbi Starting SQL thread.
2021-12-01 05:13:31.393558 98.87% [INFO] switch_core_sqldb.c:1842 sofia:external_sip Starting SQL thread.
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_without_reg
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_sip_interbi
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3454 Starting thread for external_sip
2021-12-01 05:13:31.393558 98.87% [DEBUG] sofia.c:3046 Launching worker thread for external_sip
2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'ModulusOutgoing' to profile 'external_without_reg'
2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'Interbit' to profile 'external_sip_interbi'
2021-12-01 05:13:31.413572 98.87% [NOTICE] sofia_reg.c:3735 Added gateway 'ModulusIncoming' to profile 'external_sip'
2021-12-01 05:13:32.413568 99.43% [NOTICE] sofia_reg.c:459 Registering Interbit
2021-12-01 05:13:32.413568 99.43% [NOTICE] sofia_reg.c:459 Registering ModulusIncoming
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
2021-12-01 05:13:32.893565 99.60% [CONSOLE] switch_loadable_module.c:1768 Successfully Loaded [mod_sofia]
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:172 Adding Endpoint 'sofia'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:172 Adding Endpoint 'rtp'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:329 Adding Application 'sofia_sla'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:329 Adding Application 'sofia_stir_shaken_vs'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_gateway_data'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_username_of'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_contact'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_count_reg'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_dig'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:389 Adding API Function 'sofia_presence_data'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:419 Adding JSON API Function 'sofia.status'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:419 Adding JSON API Function 'sofia.status.info'
2021-12-01 05:13:32.893565 99.60% [NOTICE] switch_loadable_module.c:621 Adding Chat interface 'sip'
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]
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
2021-12-01 05:13:49.733561 99.67% [CONSOLE] mod_voicemail.c:4065 Event Thread Started
2021-12-01 05:13:49.733561 99.67% [CONSOLE] sofia_presence.c:1620 Event Thread Started
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]
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)
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
2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 46.4.60.4:0.
2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:10585 IP 46.4.60.4 Approved by acl "default[]". Access Granted.
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]
2021-12-01 05:14:18.053566 99.03% [DEBUG] sofia.c:7509 Remote SDP:
v=0
o=FreeSWITCH 1638316494 1638316495 IN IP4 46.4.60.4
s=FreeSWITCH
c=IN IP4 46.4.60.4
t=0 0
m=audio 19164 RTP/AVP 8 18 101 13
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20

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]
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
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]
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]
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]
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
2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
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
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
2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
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
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
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
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)
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
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
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
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
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
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)
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
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
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
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
2021-12-01 05:14:18.053566 99.03% [INFO] mod_dialplan_xml.c:639 Processing +306974108809 <+306974108809>->HNR-90057 in context default
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')
2021-12-01 05:14:18.053566 99.03% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
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
stack traceback:
	[C]: in function 'dofile'
	./astpp/astpp_deb9.lua:87: in main chunk
2021-12-01 05:14:18.053566 99.03% [ERR] mod_lua.cpp:270 LUA script parse/execute error!
2021-12-01 05:14:18.053566 99.03% [WARNING] mod_dialplan_xml.c:669 Context default not found
2021-12-01 05:14:18.053566 99.03% [INFO] switch_core_state_machine.c:306 No Route, Aborting
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]
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
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)
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
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
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
2021-12-01 05:14:18.053566 99.03% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 404
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
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
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
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)
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
2021-12-01 05:14:18.053566 99.03% [INFO] mod_json_cdr.c:271 Process [93438172-78b0-4132-9a55-d451387ece6e.cdr.json]
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
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
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
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
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
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]
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)
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
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
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
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
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
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