Hi, help, I always get 404, how can I resolve it?
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [NOTICE] switch_channel.c:1142 New Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [ceb00e41-3fa7-4040-9550-7f07b15aa057]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_NEW (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [INFO] sofia.c:10459 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it receiving invite from 62.94.34.26:5060 version: 1.10.11 -release 64bit call-id: 04399885532f01b2581396005c89999b@sip2.openvoip.it
2024-10-19 14:56:19.103193 96.07% [DEBUG] sofia.c:10553 verifying acl "providers" for ip/port 62.94.34.26:0.
2024-10-19 14:56:19.103193 96.07% [DEBUG] sofia.c:10582 IP 62.94.34.26 Approved by acl "providers[]". Access Granted.
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7493 Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it entering state [received][100]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7503 Remote SDP:
ceb00e41-3fa7-4040-9550-7f07b15aa057 v=0
ceb00e41-3fa7-4040-9550-7f07b15aa057 o=root 1875948438 1875948438 IN IP4 62.94.34.26
ceb00e41-3fa7-4040-9550-7f07b15aa057 s=Asterisk PBX 18.14.0
ceb00e41-3fa7-4040-9550-7f07b15aa057 c=IN IP4 62.94.34.26
ceb00e41-3fa7-4040-9550-7f07b15aa057 t=0 0
ceb00e41-3fa7-4040-9550-7f07b15aa057 m=audio 16938 RTP/AVP 8 18 3 0 101
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:8 PCMA/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:18 G729/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=fmtp:18 annexb=no
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:3 GSM/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:0 PCMU/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:101 telephone-event/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=fmtp:101 0-16
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=ptime:20
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=maxptime:150
ceb00e41-3fa7-4040-9550-7f07b15aa057
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:3731 Set Codec sofia/external/+39xxxxxxxxxx@sip2.openvoip.it PCMA/8000 20 ms 160 samples 64000 bits 1 channels
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_codec.c:111 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Original read codec set to PCMA:8
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5856 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Set 2833 dtmf send payload to 101 recv payload to 101
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7927 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_NEW -> CS_INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:600 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State NEW
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_INIT (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:624 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] mod_sofia.c:97 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:40 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:48 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_INIT -> CS_ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:624 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State INIT going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_ROUTING (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_channel.c:2399 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Callstate Change DOWN -> RINGING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:640 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] mod_sofia.c:158 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:230 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [INFO] mod_dialplan_xml.c:639 Processing +39xxxxxxxxxx <+39xxxxxxxxxx>->104883400 in context public
2024-10-19 14:56:19.143161 96.07% [NOTICE] switch_cpp.cpp:1466 [xml_handler] multiple key:dialplan
ublic
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->caller-details] continue=true
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (PASS) [caller-details] () =~ // break=never
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action export(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it export(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_destination=${sip_to_user}) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_destination=gw+70a33655-8231-4b45-a677-9a27c7ad6251)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_destination]=[gw+70a33655-8231-4b45-a677-9a27c7ad6251]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_id_name=${caller_id_name}) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_id_name=+39xxxxxxxxxx)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_id_name]=[+39xxxxxxxxxx]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_id_number=${caller_id_number})
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->081xxxxxxx] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (FAIL) [081xxxxxxx] destination_number(104883400) =~ /^\+?(?:39)?(081xxxxxxx)$/ break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->081xxxxxxxx] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (FAIL) [081xxxxxxxx] destination_number(104883400) =~ /^(081xxxxxxxx)$/ break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->not-found] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (PASS) [not-found] () =~ // break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action export(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it export(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action log(WARNING [inbound routes] 404 not found ${sip_network_ip} destination_number ${destination_number} sip_to_user ${sip_to_user} sip_req_user ${sip_req_user})
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action respond(404 Not Found)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:281 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_ROUTING -> CS_EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:640 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State ROUTING going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_EXECUTE (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:647 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_sofia.c:213 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:323 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_id_number=+39xxxxxxxxxx)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_id_number]=[+39xxxxxxxxxx]
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it log(WARNING [inbound routes] 404 not found 62.94.34.26 destination_number 104883400 sip_to_user gw+70a33655-8231-4b45-a677-9a27c7ad6251 sip_req_user gw+70a33655-8231-4b45-a677-9a27c7ad6251)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [WARNING] mod_dptools.c:1865 [inbound routes] 404 not found 62.94.34.26 destination_number 104883400 sip_to_user gw+70a33655-8231-4b45-a677-9a27c7ad6251 sip_req_user gw+70a33655-8231-4b45-a677-9a27c7ad6251
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it respond(404 Not Found)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_sofia.c:2350 Responding with 404 [Not Found]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [NOTICE] mod_sofia.c:2416 Hangup sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [CS_EXECUTE] [UNALLOCATED_NUMBER]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_session.c:2979 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:647 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State EXECUTE going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_HANGUP (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:844 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Callstate Change RINGING -> HANGUP
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State HANGUP
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:469 Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it hanging up, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:614 Responding to INVITE with: 404
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:59 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard HANGUP, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State HANGUP going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:616 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_HANGUP -> CS_REPORTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_REPORTING (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State REPORTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:168 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard REPORTING, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State REPORTING going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:607 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_REPORTING -> CS_DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_session.c:1744 Session 1 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Locked, Waiting on external entities
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [NOTICE] switch_core_session.c:1762 Session 1 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Ended
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [NOTICE] switch_core_session.c:1766 Close Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [CS_DESTROY]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:735 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_DESTROY (Cur 0 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:380 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.263154 96.07% [DEBUG] switch_core_state_machine.c:175 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.263154 96.07% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State DESTROY going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [NOTICE] switch_channel.c:1142 New Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [ceb00e41-3fa7-4040-9550-7f07b15aa057]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_NEW (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.103193 96.07% [INFO] sofia.c:10459 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it receiving invite from 62.94.34.26:5060 version: 1.10.11 -release 64bit call-id: 04399885532f01b2581396005c89999b@sip2.openvoip.it
2024-10-19 14:56:19.103193 96.07% [DEBUG] sofia.c:10553 verifying acl "providers" for ip/port 62.94.34.26:0.
2024-10-19 14:56:19.103193 96.07% [DEBUG] sofia.c:10582 IP 62.94.34.26 Approved by acl "providers[]". Access Granted.
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7493 Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it entering state [received][100]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7503 Remote SDP:
ceb00e41-3fa7-4040-9550-7f07b15aa057 v=0
ceb00e41-3fa7-4040-9550-7f07b15aa057 o=root 1875948438 1875948438 IN IP4 62.94.34.26
ceb00e41-3fa7-4040-9550-7f07b15aa057 s=Asterisk PBX 18.14.0
ceb00e41-3fa7-4040-9550-7f07b15aa057 c=IN IP4 62.94.34.26
ceb00e41-3fa7-4040-9550-7f07b15aa057 t=0 0
ceb00e41-3fa7-4040-9550-7f07b15aa057 m=audio 16938 RTP/AVP 8 18 3 0 101
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:8 PCMA/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:18 G729/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=fmtp:18 annexb=no
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:3 GSM/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:0 PCMU/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=rtpmap:101 telephone-event/8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=fmtp:101 0-16
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=ptime:20
ceb00e41-3fa7-4040-9550-7f07b15aa057 a=maxptime:150
ceb00e41-3fa7-4040-9550-7f07b15aa057
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:3731 Set Codec sofia/external/+39xxxxxxxxxx@sip2.openvoip.it PCMA/8000 20 ms 160 samples 64000 bits 1 channels
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_codec.c:111 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Original read codec set to PCMA:8
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_media.c:5856 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Set 2833 dtmf send payload to 101 recv payload to 101
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] sofia.c:7927 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_NEW -> CS_INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:600 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State NEW
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_INIT (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:624 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] mod_sofia.c:97 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:40 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard INIT
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:48 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_INIT -> CS_ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:624 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State INIT going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_ROUTING (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_channel.c:2399 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Callstate Change DOWN -> RINGING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:640 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] mod_sofia.c:158 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [DEBUG] switch_core_state_machine.c:230 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard ROUTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.123145 96.07% [INFO] mod_dialplan_xml.c:639 Processing +39xxxxxxxxxx <+39xxxxxxxxxx>->104883400 in context public
2024-10-19 14:56:19.143161 96.07% [NOTICE] switch_cpp.cpp:1466 [xml_handler] multiple key:dialplan
ublicceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->caller-details] continue=true
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (PASS) [caller-details] () =~ // break=never
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action export(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it export(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_destination=${sip_to_user}) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_destination=gw+70a33655-8231-4b45-a677-9a27c7ad6251)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_destination]=[gw+70a33655-8231-4b45-a677-9a27c7ad6251]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_id_name=${caller_id_name}) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_id_name=+39xxxxxxxxxx)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_id_name]=[+39xxxxxxxxxx]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(caller_id_number=${caller_id_number})
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->081xxxxxxx] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (FAIL) [081xxxxxxx] destination_number(104883400) =~ /^\+?(?:39)?(081xxxxxxx)$/ break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->081xxxxxxxx] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (FAIL) [081xxxxxxxx] destination_number(104883400) =~ /^(081xxxxxxxx)$/ break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it parsing [public->not-found] continue=false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Regex (PASS) [not-found] () =~ // break=on-false
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action export(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it export(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action set(call_direction=inbound) INLINE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(call_direction=inbound)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [call_direction]=[inbound]
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action log(WARNING [inbound routes] 404 not found ${sip_network_ip} destination_number ${destination_number} sip_to_user ${sip_to_user} sip_req_user ${sip_req_user})
ceb00e41-3fa7-4040-9550-7f07b15aa057 Dialplan: sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Action respond(404 Not Found)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:281 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_ROUTING -> CS_EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:640 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State ROUTING going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_EXECUTE (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:647 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_sofia.c:213 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] switch_core_state_machine.c:323 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard EXECUTE
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it set(caller_id_number=+39xxxxxxxxxx)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_dptools.c:1671 SET sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [caller_id_number]=[+39xxxxxxxxxx]
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it log(WARNING [inbound routes] 404 not found 62.94.34.26 destination_number 104883400 sip_to_user gw+70a33655-8231-4b45-a677-9a27c7ad6251 sip_req_user gw+70a33655-8231-4b45-a677-9a27c7ad6251)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [WARNING] mod_dptools.c:1865 [inbound routes] 404 not found 62.94.34.26 destination_number 104883400 sip_to_user gw+70a33655-8231-4b45-a677-9a27c7ad6251 sip_req_user gw+70a33655-8231-4b45-a677-9a27c7ad6251
ceb00e41-3fa7-4040-9550-7f07b15aa057 EXECUTE [depth=0] sofia/external/+39xxxxxxxxxx@sip2.openvoip.it respond(404 Not Found)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [DEBUG] mod_sofia.c:2350 Responding with 404 [Not Found]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.143161 96.07% [NOTICE] mod_sofia.c:2416 Hangup sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [CS_EXECUTE] [UNALLOCATED_NUMBER]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_session.c:2979 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:647 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State EXECUTE going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_HANGUP (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:844 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Callstate Change RINGING -> HANGUP
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State HANGUP
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:469 Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it hanging up, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:614 Responding to INVITE with: 404
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:59 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard HANGUP, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State HANGUP going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:616 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_HANGUP -> CS_REPORTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_REPORTING (Cur 1 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State REPORTING
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:168 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard REPORTING, cause: UNALLOCATED_NUMBER
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State REPORTING going to sleep
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:607 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State Change CS_REPORTING -> CS_DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_session.c:1744 Session 1 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Locked, Waiting on external entities
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [NOTICE] switch_core_session.c:1762 Session 1 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Ended
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [NOTICE] switch_core_session.c:1766 Close Channel sofia/external/+39xxxxxxxxxx@sip2.openvoip.it [CS_DESTROY]
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:735 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) Running State Change CS_DESTROY (Cur 0 Tot 1)
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.163134 96.07% [DEBUG] mod_sofia.c:380 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it SOFIA DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.263154 96.07% [DEBUG] switch_core_state_machine.c:175 sofia/external/+39xxxxxxxxxx@sip2.openvoip.it Standard DESTROY
ceb00e41-3fa7-4040-9550-7f07b15aa057 2024-10-19 14:56:19.263154 96.07% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+39xxxxxxxxxx@sip2.openvoip.it) State DESTROY going to sleep