span style="color: cornflowerblue; font-weight: bold;"> 2022-04-11 05:38:23.036672 96.50% [NOTICE] switch_channel.c:1123 New Channel sofia/default/957484@ctxwebphone.astppbilling.org:5060 [b63cb920-6c4a-40fb-8328-c9b2b825b107]
2022-04-11 05:38:23.036672 96.50% [DEBUG] switch_core_state_machine.c:581 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_NEW (Cur 1 Tot 35983)
2022-04-11 05:38:23.036672 96.50% [INFO] sofia.c:10462 sofia/default/957484@ctxwebphone.astppbilling.org:5060 receiving invite from 103.240.35.46:55506 version: 1.10.7 -release-19-883d2cb662 64bit call-id: v2lone1dmsgs5vfosvgm
2022-04-11 05:38:23.036672 96.50% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.240.35.46:0.
2022-04-11 05:38:23.036672 96.50% [DEBUG] sofia.c:2419 detaching session b63cb920-6c4a-40fb-8328-c9b2b825b107
2022-04-11 05:38:23.036672 96.50% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1500@ctxwebphone.astppbilling.org] from ip 103.240.35.46
2022-04-11 05:38:23.036672 96.50% [DEBUG] switch_core_state_machine.c:600 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State NEW
2022-04-11 05:38:23.096680 96.50% [DEBUG] sofia.c:2532 Re-attaching to session b63cb920-6c4a-40fb-8328-c9b2b825b107
2022-04-11 05:38:23.096680 96.50% [INFO] sofia.c:10462 sofia/default/957484@ctxwebphone.astppbilling.org:5060 receiving invite from 103.240.35.46:55506 version: 1.10.7 -release-19-883d2cb662 64bit call-id: v2lone1dmsgs5vfosvgm
2022-04-11 05:38:23.096680 96.50% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.240.35.46:0.
2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:11672 Setting NAT mode based on via received
2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:7499 Channel sofia/default/957484@ctxwebphone.astppbilling.org:5060 entering state [received][100]
2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:7509 Remote SDP:
v=0
o=- 3009088288687459664 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R
m=audio 33839 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 103.240.35.46
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:2313719679 1 udp 2122260223 192.168.1.54 33839 typ host generation 0 network-id 1 network-cost 10
a=candidate:2147022507 1 udp 1686052607 103.240.35.46 33839 typ srflx raddr 192.168.1.54 rport 33839 generation 0 network-id 1 network-cost 10
a=candidate:3345707919 1 tcp 1518280447 192.168.1.54 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=ice-ufrag:ey0G
a=ice-pwd:7hiRKwf/Jgl1h1zNWaYjR6Ll
a=ice-options:trickle
a=fingerprint:sha-256 D8:FF:B2:09:D5:3D:3B:D4:00:03:42:7F:F8:53:65:70:96:C6:41:99:FB:45:89:77:DE:C0:D9:C4:90:7B:E0:78
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R 106ad852-2891-4fc9-9276-fe0d0ee1b395
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:3439998152 cname:ljpwx3iRc1cJnu2a
a=ssrc:3439998152 msid:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R 106ad852-2891-4fc9-9276-fe0d0ee1b395
a=ssrc:3439998152 mslabel:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R
a=ssrc:3439998152 label:106ad852-2891-4fc9-9276-fe0d0ee1b395
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 110@48000
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:3870 Set Codec sofia/default/957484@ctxwebphone.astppbilling.org:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_codec.c:111 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Original read codec set to PCMU:0
2022-04-11 05:38:23.136695 96.47% [WARNING] switch_core_media.c:4293 NO candidate ACL defined, Defaulting to wan.auto
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4344 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.1.54:33839
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4344 Save audio Candidate cid: 1 proto: udp type: srflx addr: 103.240.35.46:33839
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4389 Searching for rtp candidate.
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4398 Choose rtp candidate, index 1, 103.240.35.46:33839
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4138 sofia/default/957484@ctxwebphone.astppbilling.org:5060 choosing family v4
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4409 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 103.240.35.46:33839
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4461 setting remote audio ice addr to index 1 103.240.35.46:33839 based on candidate
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4496 Setting remote rtcp audio addr to 103.240.35.46:33839 based on candidate
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 126@8000
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5973 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Set 2833 dtmf send payload to 126 recv payload to 126
2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:7933 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State Change CS_NEW -> CS_INIT
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_INIT (Cur 1 Tot 35983)
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:624 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State INIT
2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:97 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA INIT
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:40 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Standard INIT
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:48 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State Change CS_INIT -> CS_ROUTING
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:624 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State INIT going to sleep
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_ROUTING (Cur 1 Tot 35983)
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_channel.c:2380 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Callstate Change DOWN -> RINGING
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:640 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State ROUTING
2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:158 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA ROUTING
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:230 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Standard ROUTING
2022-04-11 05:38:23.136695 96.47% [INFO] mod_dialplan_xml.c:639 Processing 957484 <957484>->1500 in context default
2022-04-11 05:38:23.136695 96.47% [ERR] mod_lua.cpp:202 cannot open /usr/local/freeswitch/scripts/astpp/constant.lua: No such file or directory
stack traceback:
[C]: in function 'dofile'
/usr/share/freeswitch/scripts/astpp/astpp.lua:36: in main chunk
2022-04-11 05:38:23.136695 96.47% [ERR] mod_lua.cpp:270 LUA script parse/execute error!
2022-04-11 05:38:23.136695 96.47% [WARNING] mod_dialplan_xml.c:669 Context default not found
2022-04-11 05:38:23.136695 96.47% [INFO] switch_core_state_machine.c:306 No Route, Aborting
2022-04-11 05:38:23.136695 96.47% [NOTICE] switch_core_state_machine.c:307 Hangup sofia/default/957484@ctxwebphone.astppbilling.org:5060 [CS_ROUTING] [NO_ROUTE_DESTINATION]
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:640 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State ROUTING going to sleep
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_HANGUP (Cur 1 Tot 35983)
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:844 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Callstate Change RINGING -> HANGUP
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:846 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State HANGUP
2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:468 Channel sofia/default/957484@ctxwebphone.astppbilling.org:5060 hanging up, cause: NO_ROUTE_DESTINATION
2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 404
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:59 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Standard HANGUP, cause: NO_ROUTE_DESTINATION
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:846 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State HANGUP going to sleep
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:616 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State Change CS_HANGUP -> CS_REPORTING
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_REPORTING (Cur 1 Tot 35983)
2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_state_machine.c:932 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State REPORTING
2022-04-11 05:38:23.136695 96.47% [INFO] mod_json_cdr.c:271 Process [b63cb920-6c4a-40fb-8328-c9b2b825b107.cdr.json]
2022-04-11 05:38:23.136695 96.47% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [957484@ctxwebphone.astppbilling.org] from ip 103.240.35.46
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:168 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Standard REPORTING, cause: NO_ROUTE_DESTINATION
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:932 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State REPORTING going to sleep
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:607 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State Change CS_REPORTING -> CS_DESTROY
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_session.c:1753 Session 35983 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Locked, Waiting on external entities
2022-04-11 05:38:23.176629 96.47% [NOTICE] switch_core_session.c:1771 Session 35983 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Ended
2022-04-11 05:38:23.176629 96.47% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/957484@ctxwebphone.astppbilling.org:5060 [CS_DESTROY]
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:735 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) Running State Change CS_DESTROY (Cur 0 Tot 35983)
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:745 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State DESTROY
2022-04-11 05:38:23.176629 96.47% [DEBUG] mod_sofia.c:379 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA DESTROY
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:175 sofia/default/957484@ctxwebphone.astppbilling.org:5060 Standard DESTROY
2022-04-11 05:38:23.176629 96.47% [DEBUG] switch_core_state_machine.c:745 (sofia/default/957484@ctxwebphone.astppbilling.org:5060) State DESTROY going to sleep
2022-04-11 05:38:31.856666 96.27% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1103@3.110.132.184 [628acb1b-9d43-4b1a-aaae-c29894e428d2]
2022-04-11 05:38:31.856666 96.27% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1103@3.110.132.184) Running State Change CS_NEW (Cur 1 Tot 35984)
2022-04-11 05:38:31.856666 96.27% [INFO] sofia.c:10462 sofia/default/1103@3.110.132.184 receiving invite from 141.98.10.78:52404 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 393349959-428472696-508566390
2022-04-11 05:38:31.856666 96.27% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 141.98.10.78:0.
2022-04-11 05:38:31.856666 96.27% [DEBUG] sofia.c:2419 detaching session 628acb1b-9d43-4b1a-aaae-c29894e428d2
2022-04-11 05:38:31.856666 96.27% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [900046812111819@3.110.132.184] from ip 141.98.10.78
2022-04-11 05:38:31.856666 96.27% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1103@3.110.132.184) State NEW