[This app Best viewed at 160x60 or more..] +OK log level [7] freeswitch@GuiOsip1ClusterQa-Alpesh> freeswitch@GuiOsip1ClusterQa-Alpesh> freeswitch@GuiOsip1ClusterQa-Alpesh> 2024-12-04 03:00:03.142695 88.87% [NOTICE] switch_channel.c:1142 New Channel sofia/default/4727985745@astppdemo.astppbilling.org [282afdf7-51e2-4401-b89f-42dc7bec1131] 2024-12-04 03:00:03.142695 88.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_NEW (Cur 1 Tot 7455) 2024-12-04 03:00:03.142695 88.87% [INFO] sofia.c:10459 sofia/default/4727985745@astppdemo.astppbilling.org receiving invite from 152.58.132.239:47718 version: 1.10.10-release 64bit call-id: ZjU1YjJiMjc2MGE4NzRhY2JjNDQ5YWY3NmJiZWM3Mzg. 2024-12-04 03:00:03.142695 88.87% [DEBUG] sofia.c:10553 verifying acl "default" for ip/port 152.58.132.239:0. 2024-12-04 03:00:03.142695 88.87% [WARNING] sofia_reg.c:1842 SIP auth challenge (INVITE) on sofia profile 'default' for [2022@astppdemo.astppbilling.org] from ip 152.58.132.239 2024-12-04 03:00:03.142695 88.87% [DEBUG] switch_core_state_machine.c:600 (sofia/default/4727985745@astppdemo.astppbilling.org) State NEW 2024-12-04 03:00:03.142695 88.87% [DEBUG] sofia.c:2419 detaching session 282afdf7-51e2-4401-b89f-42dc7bec1131 2024-12-04 03:00:04.002727 88.87% [DEBUG] sofia.c:2532 Re-attaching to session 282afdf7-51e2-4401-b89f-42dc7bec1131 2024-12-04 03:00:04.002727 88.87% [INFO] sofia.c:10459 sofia/default/4727985745@astppdemo.astppbilling.org receiving invite from 152.58.132.239:47718 version: 1.10.10-release 64bit call-id: ZjU1YjJiMjc2MGE4NzRhY2JjNDQ5YWY3NmJiZWM3Mzg. 2024-12-04 03:00:04.002727 88.87% [DEBUG] sofia.c:10553 verifying acl "default" for ip/port 152.58.132.239:0. 2024-12-04 03:00:04.022712 88.87% [DEBUG] sofia.c:11674 Setting NAT mode based on via port 2024-12-04 03:00:04.022712 88.87% [DEBUG] sofia.c:7493 Channel sofia/default/4727985745@astppdemo.astppbilling.org entering state [received][100] 2024-12-04 03:00:04.022712 88.87% [DEBUG] sofia.c:7503 Remote SDP: v=0 o=Z 0 0 IN IP4 152.58.132.239 s=Z c=IN IP4 152.58.132.239 t=0 0 m=audio 8000 RTP/AVP 3 110 8 0 98 101 a=rtpmap:110 speex/8000 a=rtpmap:98 iLBC/8000 a=fmtp:98 mode=20 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1] 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/4727985745@astppdemo.astppbilling.org PCMA/8000 20 ms 160 samples 64000 bits 1 channels 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_codec.c:111 sofia/default/4727985745@astppdemo.astppbilling.org Original read codec set to PCMA:8 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_media.c:5856 sofia/default/4727985745@astppdemo.astppbilling.org Set 2833 dtmf send payload to 101 recv payload to 101 2024-12-04 03:00:04.022712 88.87% [DEBUG] sofia.c:7927 (sofia/default/4727985745@astppdemo.astppbilling.org) State Change CS_NEW -> CS_INIT 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_INIT (Cur 1 Tot 7455) 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/4727985745@astppdemo.astppbilling.org) State INIT 2024-12-04 03:00:04.022712 88.87% [DEBUG] mod_sofia.c:97 sofia/default/4727985745@astppdemo.astppbilling.org SOFIA INIT 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:40 sofia/default/4727985745@astppdemo.astppbilling.org Standard INIT 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:48 (sofia/default/4727985745@astppdemo.astppbilling.org) State Change CS_INIT -> CS_ROUTING 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/4727985745@astppdemo.astppbilling.org) State INIT going to sleep 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_ROUTING (Cur 1 Tot 7455) 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_channel.c:2399 (sofia/default/4727985745@astppdemo.astppbilling.org) Callstate Change DOWN -> RINGING 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/4727985745@astppdemo.astppbilling.org) State ROUTING 2024-12-04 03:00:04.022712 88.87% [DEBUG] mod_sofia.c:158 sofia/default/4727985745@astppdemo.astppbilling.org SOFIA ROUTING 2024-12-04 03:00:04.022712 88.87% [DEBUG] switch_core_state_machine.c:230 sofia/default/4727985745@astppdemo.astppbilling.org Standard ROUTING 2024-12-04 03:00:04.022712 88.87% [INFO] mod_dialplan_xml.c:639 Processing 4727985745 <4727985745>->2022 in context default 2024-12-04 03:00:04.042710 88.87% [INFO] switch_cpp.cpp:1465 [ASTPP] USING CACHE 2024-12-04 03:00:04.042710 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0 2024-12-04 03:00:04.042710 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0 2024-12-04 03:00:04.042710 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons 2024-12-04 03:00:04.062712 88.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 2022 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.0 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.1 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.2 :: CALL IS ACCESS NUMBER 2024-12-04 03:00:04.062712 88.87% [ERR] mod_lua.cpp:202 /usr/local/freeswitch/scripts/astpp/scripts/astpp.xml.lua:1342: attempt to concatenate a nil value stack traceback: /usr/local/freeswitch/scripts/astpp/scripts/astpp.xml.lua:1342: in function 'generate_cc_dialplan' ...ocal/freeswitch/scripts/astpp/scripts/astpp.dialplan.lua:102: in main chunk [C]: in function 'dofile' /usr/local/freeswitch/scripts/astpp/astpp.lua:144: in main chunk 2024-12-04 03:00:04.062712 88.87% [ERR] mod_lua.cpp:269 LUA script parse/execute error! 2024-12-04 03:00:04.062712 88.87% [WARNING] mod_dialplan_xml.c:669 Context default not found 2024-12-04 03:00:04.062712 88.87% [INFO] switch_core_state_machine.c:306 No Route, Aborting 2024-12-04 03:00:04.062712 88.87% [NOTICE] switch_core_state_machine.c:307 Hangup sofia/default/4727985745@astppdemo.astppbilling.org [CS_ROUTING] [NO_ROUTE_DESTINATION] 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/4727985745@astppdemo.astppbilling.org) State ROUTING going to sleep 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_HANGUP (Cur 1 Tot 7455) 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:844 (sofia/default/4727985745@astppdemo.astppbilling.org) Callstate Change RINGING -> HANGUP 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4727985745@astppdemo.astppbilling.org) State HANGUP 2024-12-04 03:00:04.062712 88.87% [DEBUG] mod_sofia.c:469 Channel sofia/default/4727985745@astppdemo.astppbilling.org hanging up, cause: NO_ROUTE_DESTINATION 2024-12-04 03:00:04.062712 88.87% [DEBUG] mod_sofia.c:614 Responding to INVITE with: 404 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:59 sofia/default/4727985745@astppdemo.astppbilling.org Standard HANGUP, cause: NO_ROUTE_DESTINATION 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4727985745@astppdemo.astppbilling.org) State HANGUP going to sleep 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:616 (sofia/default/4727985745@astppdemo.astppbilling.org) State Change CS_HANGUP -> CS_REPORTING 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_REPORTING (Cur 1 Tot 7455) 2024-12-04 03:00:04.062712 88.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4727985745@astppdemo.astppbilling.org) State REPORTING 2024-12-04 03:00:04.062712 88.87% [INFO] mod_json_cdr.c:272 Process [282afdf7-51e2-4401-b89f-42dc7bec1131.cdr.json] 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:168 sofia/default/4727985745@astppdemo.astppbilling.org Standard REPORTING, cause: NO_ROUTE_DESTINATION 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4727985745@astppdemo.astppbilling.org) State REPORTING going to sleep 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:607 (sofia/default/4727985745@astppdemo.astppbilling.org) State Change CS_REPORTING -> CS_DESTROY 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_session.c:1744 Session 7455 (sofia/default/4727985745@astppdemo.astppbilling.org) Locked, Waiting on external entities 2024-12-04 03:00:04.082693 88.87% [NOTICE] switch_core_session.c:1762 Session 7455 (sofia/default/4727985745@astppdemo.astppbilling.org) Ended 2024-12-04 03:00:04.082693 88.87% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/4727985745@astppdemo.astppbilling.org [CS_DESTROY] 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:735 (sofia/default/4727985745@astppdemo.astppbilling.org) Running State Change CS_DESTROY (Cur 0 Tot 7455) 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4727985745@astppdemo.astppbilling.org) State DESTROY 2024-12-04 03:00:04.082693 88.87% [DEBUG] mod_sofia.c:380 sofia/default/4727985745@astppdemo.astppbilling.org SOFIA DESTROY 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:175 sofia/default/4727985745@astppdemo.astppbilling.org Standard DESTROY 2024-12-04 03:00:04.082693 88.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4727985745@astppdemo.astppbilling.org) State DESTROY going to sleep freeswitch@GuiOsip1ClusterQa-Alpesh> freeswitch@GuiOsip1ClusterQa-Alpesh> /exit