From WhenDialingAgentDialNumber, 2 Years ago, written in FreeSWITCH.
- go back
Embed
Viewing differences between and ASTPPENT3996
  1. 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]
  2. 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)
  3. 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
  4. 2022-04-11 05:38:23.036672 96.50% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.240.35.46:0.
  5. 2022-04-11 05:38:23.036672 96.50% [DEBUG] sofia.c:2419 detaching session b63cb920-6c4a-40fb-8328-c9b2b825b107
  6. 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
  7. 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
  8. 2022-04-11 05:38:23.096680 96.50% [DEBUG] sofia.c:2532 Re-attaching to session b63cb920-6c4a-40fb-8328-c9b2b825b107
  9. 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
  10. 2022-04-11 05:38:23.096680 96.50% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.240.35.46:0.
  11. 2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:11672 Setting NAT mode based on via received
  12. 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]
  13. 2022-04-11 05:38:23.136695 96.47% [DEBUG] sofia.c:7509 Remote SDP:
  14. v=0
  15. o=- 3009088288687459664 2 IN IP4 127.0.0.1
  16. s=-
  17. t=0 0
  18. a=group:BUNDLE 0
  19. a=extmap-allow-mixed
  20. a=msid-semantic: WMS URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R
  21. m=audio 33839 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
  22. c=IN IP4 103.240.35.46
  23. a=rtpmap:111 opus/48000/2
  24. a=fmtp:111 minptime=10;useinbandfec=1
  25. a=rtpmap:103 ISAC/16000
  26. a=rtpmap:104 ISAC/32000
  27. a=rtpmap:9 G722/8000
  28. a=rtpmap:0 PCMU/8000
  29. a=rtpmap:8 PCMA/8000
  30. a=rtpmap:106 CN/32000
  31. a=rtpmap:105 CN/16000
  32. a=rtpmap:13 CN/8000
  33. a=rtpmap:110 telephone-event/48000
  34. a=rtpmap:112 telephone-event/32000
  35. a=rtpmap:113 telephone-event/16000
  36. a=rtpmap:126 telephone-event/8000
  37. a=rtcp:9 IN IP4 0.0.0.0
  38. a=candidate:2313719679 1 udp 2122260223 192.168.1.54 33839 typ host generation 0 network-id 1 network-cost 10
  39. 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
  40. a=candidate:3345707919 1 tcp 1518280447 192.168.1.54 9 typ host tcptype active generation 0 network-id 1 network-cost 10
  41. a=ice-ufrag:ey0G
  42. a=ice-pwd:7hiRKwf/Jgl1h1zNWaYjR6Ll
  43. a=ice-options:trickle
  44. 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
  45. a=setup:actpass
  46. a=mid:0
  47. a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
  48. a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
  49. a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
  50. a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
  51. a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
  52. a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
  53. a=msid:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R 106ad852-2891-4fc9-9276-fe0d0ee1b395
  54. a=rtcp-mux
  55. a=rtcp-fb:111 transport-cc
  56. a=ssrc:3439998152 cname:ljpwx3iRc1cJnu2a
  57. a=ssrc:3439998152 msid:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R 106ad852-2891-4fc9-9276-fe0d0ee1b395
  58. a=ssrc:3439998152 mslabel:URkAi1RJWuIvMvkDtDyehSFJSnoqPBDl1s7R
  59. a=ssrc:3439998152 label:106ad852-2891-4fc9-9276-fe0d0ee1b395
  60.  
  61. 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]
  62. 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]
  63. 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]
  64. 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]
  65. 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]
  66. 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]
  67. 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]
  68. 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]
  69. 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]
  70. 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]
  71. 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
  72. 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]
  73. 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
  74. 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]
  75. 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]
  76. 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]
  77. 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]
  78. 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]
  79. 2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 110@48000
  80. 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
  81. 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
  82. 2022-04-11 05:38:23.136695 96.47% [WARNING] switch_core_media.c:4293 NO candidate ACL defined, Defaulting to wan.auto
  83. 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
  84. 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
  85. 2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:4389 Searching for rtp candidate.
  86. 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
  87. 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
  88. 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
  89. 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
  90. 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
  91. 2022-04-11 05:38:23.136695 96.47% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 126@8000
  92. 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
  93. 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
  94. 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)
  95. 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
  96. 2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:97 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA INIT
  97. 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
  98. 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
  99. 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
  100. 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)
  101. 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
  102. 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
  103. 2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:158 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA ROUTING
  104. 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
  105. 2022-04-11 05:38:23.136695 96.47% [INFO] mod_dialplan_xml.c:639 Processing 957484 <957484>->1500 in context default
  106. 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
  107. stack traceback:
  108.         [C]: in function 'dofile'
  109.         /usr/share/freeswitch/scripts/astpp/astpp.lua:36: in main chunk
  110. 2022-04-11 05:38:23.136695 96.47% [ERR] mod_lua.cpp:270 LUA script parse/execute error!
  111. 2022-04-11 05:38:23.136695 96.47% [WARNING] mod_dialplan_xml.c:669 Context default not found
  112. 2022-04-11 05:38:23.136695 96.47% [INFO] switch_core_state_machine.c:306 No Route, Aborting
  113. 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]
  114. 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
  115. 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)
  116. 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
  117. 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
  118. 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
  119. 2022-04-11 05:38:23.136695 96.47% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 404
  120. 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
  121. 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
  122. 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
  123. 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)
  124. 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
  125. 2022-04-11 05:38:23.136695 96.47% [INFO] mod_json_cdr.c:271 Process [b63cb920-6c4a-40fb-8328-c9b2b825b107.cdr.json]
  126. 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
  127. 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
  128. 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
  129. 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
  130. 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
  131. 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
  132. 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]
  133. 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)
  134. 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
  135. 2022-04-11 05:38:23.176629 96.47% [DEBUG] mod_sofia.c:379 sofia/default/957484@ctxwebphone.astppbilling.org:5060 SOFIA DESTROY
  136. 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
  137. 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
  138. 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]
  139. 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)
  140. 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
  141. 2022-04-11 05:38:31.856666 96.27% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 141.98.10.78:0.
  142. 2022-04-11 05:38:31.856666 96.27% [DEBUG] sofia.c:2419 detaching session 628acb1b-9d43-4b1a-aaae-c29894e428d2
  143. 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
  144. 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
  145.