freeswitch@santral> freeswitch@santral> 2021-10-25 09:21:23.564071 [NOTICE] switch_channel.c:1118 New Channel sofia/local/2730@10.0.1.15 [d1173c02-23a3-47d3-99cf-00577eb2b56f] 2021-10-25 09:21:23.564071 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_NEW (Cur 1 Tot 126) 2021-10-25 09:21:23.564071 [INFO] sofia.c:10362 sofia/local/2730@10.0.1.15 receiving invite from 172.19.148.130:53127 version: 1.10.6 -release-18-1ff9d0a60e 64bit call-id: 001f6c7e-841000c0-4d417d44-902eac24@172.19.148.130 2021-10-25 09:21:23.584075 [DEBUG] switch_core_state_machine.c:604 (sofia/local/2730@10.0.1.15) State NEW 2021-10-25 09:21:23.584075 [DEBUG] sofia.c:2447 detaching session d1173c02-23a3-47d3-99cf-00577eb2b56f 2021-10-25 09:21:23.624084 [DEBUG] sofia.c:2562 Re-attaching to session d1173c02-23a3-47d3-99cf-00577eb2b56f 2021-10-25 09:21:23.624084 [INFO] sofia.c:10362 sofia/local/2730@10.0.1.15 receiving invite from 172.19.148.130:53127 version: 1.10.6 -release-18-1ff9d0a60e 64bit call-id: 001f6c7e-841000c0-4d417d44-902eac24@172.19.148.130 2021-10-25 09:21:23.624084 [DEBUG] sofia.c:7406 Channel sofia/local/2730@10.0.1.15 entering state [received][100] 2021-10-25 09:21:23.624084 [DEBUG] sofia.c:7416 Remote SDP: v=0 o=Cisco-SIPUA 26753 0 IN IP4 172.19.148.130 s=SIP Call t=0 0 m=audio 18354 RTP/AVP 9 0 8 18 102 116 101 c=IN IP4 172.19.148.130 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:102 L16/16000 a=rtpmap:116 iLBC/8000 a=fmtp:116 mode=20 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2021-10-25 09:21:23.624084 [DEBUG] sofia.c:7819 (sofia/local/2730@10.0.1.15) State Change CS_NEW -> CS_INIT 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_INIT (Cur 1 Tot 126) 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:628 (sofia/local/2730@10.0.1.15) State INIT 2021-10-25 09:21:23.624084 [DEBUG] mod_sofia.c:93 sofia/local/2730@10.0.1.15 SOFIA INIT 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:40 sofia/local/2730@10.0.1.15 Standard INIT 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:48 (sofia/local/2730@10.0.1.15) State Change CS_INIT -> CS_ROUTING 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:628 (sofia/local/2730@10.0.1.15) State INIT going to sleep 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_ROUTING (Cur 1 Tot 126) 2021-10-25 09:21:23.624084 [DEBUG] switch_channel.c:2332 (sofia/local/2730@10.0.1.15) Callstate Change DOWN -> RINGING 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:644 (sofia/local/2730@10.0.1.15) State ROUTING 2021-10-25 09:21:23.624084 [DEBUG] mod_sofia.c:154 sofia/local/2730@10.0.1.15 SOFIA ROUTING 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:236 sofia/local/2730@10.0.1.15 Standard ROUTING 2021-10-25 09:21:23.624084 [INFO] mod_dialplan_xml.c:637 Processing Rahman DURAN <2730>->2110 in context local Dialplan: sofia/local/2730@10.0.1.15 parsing [local->unloop] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->redial] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [redial] destination_number(2110) =~ /^redial$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->kapatilan_numaralar_icin_ozel_anonslar_ubys] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [kapatilan_numaralar_icin_ozel_anonslar_ubys] destination_number(2110) =~ /^(2708|2731|2788)$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->call_forwarding_activativation] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [call_forwarding_activativation] destination_number(2110) =~ /^\*72(\d+)$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->call_forwarding_deactivation] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [call_forwarding_deactivation] destination_number(2110) =~ /^\*72$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->echo_test] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [echo_test] destination_number(2110) =~ /^\*777$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->group_call_pickup] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [group_call_pickup] destination_number(2110) =~ /^\*82$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->call_pickup] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [call_pickup] destination_number(2110) =~ /^\*80(\d{4})$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->yemek-menu] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [yemek-menu] destination_number(2110) =~ /^5001$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->emergency] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [emergency] destination_number(2110) =~ /^(112|155)$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->ground_zero] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [ground_zero] destination_number(2110) =~ /^0$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->group_call_1220] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [group_call_1220] destination_number(2110) =~ /^(1220)$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->ivr-ext-1230] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [ivr-ext-1230] destination_number(2110) =~ /^1230$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->call_forwarding_number] continue=true Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [call_forwarding_number] ${destination_number}(2110) =~ /^\d{4}$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 Action set(call_forwarding_number=${db(select/${domain_name}-call_forward/${destination_number})}) INLINE EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(call_forwarding_number=) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [call_forwarding_number]=[UNDEF] Dialplan: sofia/local/2730@10.0.1.15 parsing [local->check_call_forwarding] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [check_call_forwarding] destination_number(2110) =~ /^\d{4}$/ match=all Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [check_call_forwarding] ${call_forwarding_number}() =~ /^\d+$/ match=all Dialplan: sofia/local/2730@10.0.1.15 parsing [local->call_restrict] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [call_restrict] ${destination_number}(2110) =~ /^\d{4}$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [call_restrict] ${user_data(${destination_number}@${domain_name} var acl-kontrol)}(False) =~ /^true$|^True$|^TRUE$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [local->local_accounts_set_vars] continue=true Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [local_accounts_set_vars] destination_number(2110) =~ /^[0-9]{4}$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 Action set(local_user_exists=${user_exists(id ${destination_number} ${domain_name})}) INLINE EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(local_user_exists=true) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [local_user_exists]=[true] Dialplan: sofia/local/2730@10.0.1.15 Action set(santral_kontrol=${user_data(${destination_number}@${domain_name} var hangi_santral)}) INLINE EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(santral_kontrol=freeswitch) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [santral_kontrol]=[freeswitch] Dialplan: sofia/local/2730@10.0.1.15 parsing [local->local_accounts_freeswitch] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [local_accounts_freeswitch] destination_number(2110) =~ /^[0-9]{4}$/ match=all Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [local_accounts_freeswitch] ${local_user_exists}(true) =~ /^true$|^TRUE$|^True$/ match=all Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [local_accounts_freeswitch] ${santral_kontrol}(freeswitch) =~ /^freeswitch$/ match=all Dialplan: sofia/local/2730@10.0.1.15 Action set(call_pickup_group=${user_data(${destination_number}@${domain_name} var call_pickup_group)}) INLINE EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(call_pickup_group=) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [call_pickup_group]=[UNDEF] Dialplan: sofia/local/2730@10.0.1.15 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/local/2730@10.0.1.15 Action hash(insert/${domain_name}-group_pickup_last_uuid/${call_pickup_group}/${uuid}) Dialplan: sofia/local/2730@10.0.1.15 Action hash(insert/${domain_name}-pickup_last_uuid/${destination_number}/${uuid}) Dialplan: sofia/local/2730@10.0.1.15 Action log(ep_codec_string -- ${ep_codec_string}) Dialplan: sofia/local/2730@10.0.1.15 Action set(inherit_codec=true) Dialplan: sofia/local/2730@10.0.1.15 Action export(nolocal:absolute_codec_string='${ep_codec_string}') Dialplan: sofia/local/2730@10.0.1.15 Action set_profile_var(callee_id_name=${user_data(${destination_number}@${domain_name} var effective_caller_id_name)}) Dialplan: sofia/local/2730@10.0.1.15 Action set(hangup_after_bridge=true) Dialplan: sofia/local/2730@10.0.1.15 Action set(continue_on_fail=true) Dialplan: sofia/local/2730@10.0.1.15 Action set(call_timeout=30) Dialplan: sofia/local/2730@10.0.1.15 Action set(execute_on_answer=sched_hangup +21600 alloted_timeout) Dialplan: sofia/local/2730@10.0.1.15 Action bridge({origination_callee_id_name=${user_data(${destination_number}@${domain_name} var effective_caller_id_name)}}user/${destination_number}@${domain_name}) Dialplan: sofia/local/2730@10.0.1.15 Action execute_extension(hata-${originate_disposition} XML hata_anonslari) 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:287 (sofia/local/2730@10.0.1.15) State Change CS_ROUTING -> CS_EXECUTE 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:644 (sofia/local/2730@10.0.1.15) State ROUTING going to sleep 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_EXECUTE (Cur 1 Tot 126) 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:651 (sofia/local/2730@10.0.1.15) State EXECUTE 2021-10-25 09:21:23.624084 [DEBUG] mod_sofia.c:209 sofia/local/2730@10.0.1.15 SOFIA EXECUTE 2021-10-25 09:21:23.624084 [DEBUG] switch_core_state_machine.c:329 sofia/local/2730@10.0.1.15 Standard EXECUTE EXECUTE [depth=0] sofia/local/2730@10.0.1.15 hash(insert/10.0.1.15-last_dial/2730/2110) EXECUTE [depth=0] sofia/local/2730@10.0.1.15 hash(insert/10.0.1.15-group_pickup_last_uuid//d1173c02-23a3-47d3-99cf-00577eb2b56f) EXECUTE [depth=0] sofia/local/2730@10.0.1.15 hash(insert/10.0.1.15-pickup_last_uuid/2110/d1173c02-23a3-47d3-99cf-00577eb2b56f) EXECUTE [depth=0] sofia/local/2730@10.0.1.15 log(ep_codec_string -- mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1879 -- mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(inherit_codec=true) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [inherit_codec]=[true] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 export(nolocal:absolute_codec_string='mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b') 2021-10-25 09:21:23.624084 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) (REMOTE ONLY) [absolute_codec_string]=['mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set_profile_var(callee_id_name=Erkan Özyılmaz) EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(hangup_after_bridge=true) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [hangup_after_bridge]=[true] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(continue_on_fail=true) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [continue_on_fail]=[true] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(call_timeout=30) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [call_timeout]=[30] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 set(execute_on_answer=sched_hangup +21600 alloted_timeout) 2021-10-25 09:21:23.624084 [DEBUG] mod_dptools.c:1685 SET sofia/local/2730@10.0.1.15 [execute_on_answer]=[sched_hangup +21600 alloted_timeout] EXECUTE [depth=0] sofia/local/2730@10.0.1.15 bridge({origination_callee_id_name=Erkan Özyılmaz}user/2110@10.0.1.15) 2021-10-25 09:21:23.644858 [DEBUG] switch_channel.c:1264 sofia/local/2730@10.0.1.15 EXPORTING[export_vars] [absolute_codec_string]=['mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'] to event 2021-10-25 09:21:23.644858 [DEBUG] switch_ivr_originate.c:2272 Parsing global variables 2021-10-25 09:21:23.644858 [DEBUG] switch_channel.c:1264 sofia/local/2730@10.0.1.15 EXPORTING[export_vars] [absolute_codec_string]=['mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'] to event 2021-10-25 09:21:23.644858 [DEBUG] switch_ivr_originate.c:2272 Parsing global variables 2021-10-25 09:21:23.644858 [NOTICE] switch_channel.c:1118 New Channel sofia/local/2110@172.19.148.41 [284c2542-f74d-43bd-ba14-ca50329b64c3] 2021-10-25 09:21:23.644858 [DEBUG] mod_sofia.c:5102 (sofia/local/2110@172.19.148.41) State Change CS_NEW -> CS_INIT 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2110@172.19.148.41) Running State Change CS_INIT (Cur 2 Tot 127) 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:628 (sofia/local/2110@172.19.148.41) State INIT 2021-10-25 09:21:23.644858 [DEBUG] mod_sofia.c:93 sofia/local/2110@172.19.148.41 SOFIA INIT 2021-10-25 09:21:23.644858 [INFO] sofia_glue.c:1621 sofia/local/2110@172.19.148.41 sending invite call-id: (null) 2021-10-25 09:21:23.644858 [DEBUG] sofia_glue.c:1624 sofia/local/2110@172.19.148.41 sending invite version: 1.10.6 -release-18-1ff9d0a60e 64bit Local SDP: v=0 o=FreeSWITCH 1635118347 1635118348 IN IP4 10.0.1.15 s=FreeSWITCH c=IN IP4 10.0.1.15 t=0 0 m=audio 24536 RTP/AVP 9 101 13 a=rtpmap:9 G722/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 a=sendrecv 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:40 sofia/local/2110@172.19.148.41 Standard INIT 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:48 (sofia/local/2110@172.19.148.41) State Change CS_INIT -> CS_ROUTING 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:628 (sofia/local/2110@172.19.148.41) State INIT going to sleep 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2110@172.19.148.41) Running State Change CS_ROUTING (Cur 2 Tot 127) 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:644 (sofia/local/2110@172.19.148.41) State ROUTING 2021-10-25 09:21:23.644858 [DEBUG] mod_sofia.c:154 sofia/local/2110@172.19.148.41 SOFIA ROUTING 2021-10-25 09:21:23.644858 [DEBUG] switch_ivr_originate.c:67 (sofia/local/2110@172.19.148.41) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:644 (sofia/local/2110@172.19.148.41) State ROUTING going to sleep 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2110@172.19.148.41) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 127) 2021-10-25 09:21:23.644858 [DEBUG] sofia.c:7406 Channel sofia/local/2110@172.19.148.41 entering state [calling][0] 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:663 (sofia/local/2110@172.19.148.41) State CONSUME_MEDIA 2021-10-25 09:21:23.644858 [DEBUG] switch_core_state_machine.c:663 (sofia/local/2110@172.19.148.41) State CONSUME_MEDIA going to sleep 2021-10-25 09:21:23.724066 [DEBUG] sofia.c:7406 Channel sofia/local/2110@172.19.148.41 entering state [terminated][488] 2021-10-25 09:21:23.724066 [NOTICE] sofia.c:8641 Hangup sofia/local/2110@172.19.148.41 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2110@172.19.148.41) Running State Change CS_HANGUP (Cur 2 Tot 127) 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:848 (sofia/local/2110@172.19.148.41) Callstate Change DOWN -> HANGUP 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:850 (sofia/local/2110@172.19.148.41) State HANGUP 2021-10-25 09:21:23.724066 [DEBUG] mod_sofia.c:453 Channel sofia/local/2110@172.19.148.41 hanging up, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:60 sofia/local/2110@172.19.148.41 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:850 (sofia/local/2110@172.19.148.41) State HANGUP going to sleep 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:620 (sofia/local/2110@172.19.148.41) State Change CS_HANGUP -> CS_REPORTING 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2110@172.19.148.41) Running State Change CS_REPORTING (Cur 2 Tot 127) 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:936 (sofia/local/2110@172.19.148.41) State REPORTING 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:174 sofia/local/2110@172.19.148.41 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:936 (sofia/local/2110@172.19.148.41) State REPORTING going to sleep 2021-10-25 09:21:23.724066 [DEBUG] switch_core_state_machine.c:611 (sofia/local/2110@172.19.148.41) State Change CS_REPORTING -> CS_DESTROY 2021-10-25 09:21:23.724066 [DEBUG] switch_core_session.c:1736 Session 127 (sofia/local/2110@172.19.148.41) Locked, Waiting on external entities 2021-10-25 09:21:23.744065 [DEBUG] switch_ivr_originate.c:4026 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:1754 Session 127 (sofia/local/2110@172.19.148.41) Ended 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:1758 Close Channel sofia/local/2110@172.19.148.41 [CS_DESTROY] 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:739 (sofia/local/2110@172.19.148.41) Running State Change CS_DESTROY (Cur 1 Tot 127) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:749 (sofia/local/2110@172.19.148.41) State DESTROY 2021-10-25 09:21:23.744065 [DEBUG] mod_sofia.c:364 sofia/local/2110@172.19.148.41 SOFIA DESTROY 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:181 sofia/local/2110@172.19.148.41 Standard DESTROY 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:749 (sofia/local/2110@172.19.148.41) State DESTROY going to sleep 2021-10-25 09:21:23.744065 [NOTICE] switch_ivr_originate.c:3030 Cannot create outgoing channel of type [user] cause: [INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.744065 [DEBUG] switch_ivr_originate.c:4026 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.744065 [INFO] mod_dptools.c:3643 Originate Failed. Cause: INCOMPATIBLE_DESTINATION EXECUTE [depth=0] sofia/local/2730@10.0.1.15 execute_extension(hata-INCOMPATIBLE_DESTINATION XML hata_anonslari) 2021-10-25 09:21:23.744065 [INFO] mod_dialplan_xml.c:637 Processing Rahman DURAN <2730>->hata-INCOMPATIBLE_DESTINATION in context hata_anonslari Dialplan: sofia/local/2730@10.0.1.15 parsing [hata_anonslari->error-causes-user_busy] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [error-causes-user_busy] destination_number(hata-INCOMPATIBLE_DESTINATION) =~ /^hata-USER_BUSY$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [hata_anonslari->error-causes-no_answer] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [error-causes-no_answer] destination_number(hata-INCOMPATIBLE_DESTINATION) =~ /^hata-NO_ANSWER$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [hata_anonslari->error-causes-user_not_registered] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (FAIL) [error-causes-user_not_registered] destination_number(hata-INCOMPATIBLE_DESTINATION) =~ /^hata-USER_NOT_REGISTERED$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 parsing [hata_anonslari->error-causes-any] continue=false Dialplan: sofia/local/2730@10.0.1.15 Regex (PASS) [error-causes-any] destination_number(hata-INCOMPATIBLE_DESTINATION) =~ /^hata-(.*)$/ break=on-false Dialplan: sofia/local/2730@10.0.1.15 Action export(cdr_hata_anonsu=${originate_disposition}) Dialplan: sofia/local/2730@10.0.1.15 Action hangup(${originate_disposition}) 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:3026 Execute [depth=1] export(cdr_hata_anonsu=${originate_disposition}) EXECUTE [depth=1] sofia/local/2730@10.0.1.15 export(cdr_hata_anonsu=INCOMPATIBLE_DESTINATION) 2021-10-25 09:21:23.744065 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [cdr_hata_anonsu]=[INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:3026 Execute [depth=1] hangup(${originate_disposition}) EXECUTE [depth=1] sofia/local/2730@10.0.1.15 hangup(INCOMPATIBLE_DESTINATION) 2021-10-25 09:21:23.744065 [NOTICE] mod_dptools.c:1387 Hangup sofia/local/2730@10.0.1.15 [CS_EXECUTE] [INCOMPATIBLE_DESTINATION] 2021-10-25 09:21:23.744065 [DEBUG] switch_core_session.c:2914 sofia/local/2730@10.0.1.15 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_session.c:2914 sofia/local/2730@10.0.1.15 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:651 (sofia/local/2730@10.0.1.15) State EXECUTE going to sleep 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_HANGUP (Cur 1 Tot 127) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:848 (sofia/local/2730@10.0.1.15) Callstate Change RINGING -> HANGUP 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:850 (sofia/local/2730@10.0.1.15) State HANGUP 2021-10-25 09:21:23.744065 [DEBUG] mod_sofia.c:447 sofia/local/2730@10.0.1.15 Overriding SIP cause 488 with 488 from the other leg 2021-10-25 09:21:23.744065 [DEBUG] mod_sofia.c:453 Channel sofia/local/2730@10.0.1.15 hanging up, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.744065 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 488 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:60 sofia/local/2730@10.0.1.15 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:850 (sofia/local/2730@10.0.1.15) State HANGUP going to sleep 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:620 (sofia/local/2730@10.0.1.15) State Change CS_HANGUP -> CS_REPORTING 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:585 (sofia/local/2730@10.0.1.15) Running State Change CS_REPORTING (Cur 1 Tot 127) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:936 (sofia/local/2730@10.0.1.15) State REPORTING 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:174 sofia/local/2730@10.0.1.15 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:936 (sofia/local/2730@10.0.1.15) State REPORTING going to sleep 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:611 (sofia/local/2730@10.0.1.15) State Change CS_REPORTING -> CS_DESTROY 2021-10-25 09:21:23.744065 [DEBUG] switch_core_session.c:1736 Session 126 (sofia/local/2730@10.0.1.15) Locked, Waiting on external entities 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:1754 Session 126 (sofia/local/2730@10.0.1.15) Ended 2021-10-25 09:21:23.744065 [NOTICE] switch_core_session.c:1758 Close Channel sofia/local/2730@10.0.1.15 [CS_DESTROY] 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:739 (sofia/local/2730@10.0.1.15) Running State Change CS_DESTROY (Cur 0 Tot 127) 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:749 (sofia/local/2730@10.0.1.15) State DESTROY 2021-10-25 09:21:23.744065 [DEBUG] mod_sofia.c:364 sofia/local/2730@10.0.1.15 SOFIA DESTROY 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:181 sofia/local/2730@10.0.1.15 Standard DESTROY 2021-10-25 09:21:23.744065 [DEBUG] switch_core_state_machine.c:749 (sofia/local/2730@10.0.1.15) State DESTROY going to sleep freeswitch@santral> freeswitch@santral> freeswitch@santral>