Newbie with FussionPBX, any help will be greatly appreciated..
I am having problems with calls from PTSN to Voip Client..
The originating caller receives a fast busy..
Calls from VOIP Client to PTSN DO WORK and calls between extensions DO WORK PROPERLY...
Problem are with external calls to VOIP Client.
Using FLOW ROUTE as provider....
Number being called is +1-786-991-9204
This the FreeSwtich Log...
2022-04-06 11:26:05.243056 99.73% [DEBUG] sofia_reg.c:2665 Changing expire time to 298 by request of proxy sip:us-east-va.sip.flowroute.com
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [NOTICE] switch_channel.c:1123 New Channel sofia/external/+17549717866@fl.gg [7856c4e7-39e0-43a1-b670-e8d3c2424fbc]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_NEW (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [INFO] sofia.c:10462 sofia/external/+17549717866@fl.gg receiving invite from 34.226.36.32:5060 version: 1.10.7 -release 64bit call-id: 4725772_58319130@207.223.78.224
2022-04-06 11:28:07.623060 99.90% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 34.226.36.32:0.
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [DEBUG] switch_core_state_machine.c:600 (sofia/external/+17549717866@fl.gg) State NEW
2022-04-06 11:28:07.623060 99.90% [DEBUG] sofia.c:2419 detaching session 7856c4e7-39e0-43a1-b670-e8d3c2424fbc
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [WARNING] switch_core_state_machine.c:684 7856c4e7-39e0-43a1-b670-e8d3c2424fbc sofia/external/+17549717866@fl.gg Abandoned
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/external/+17549717866@fl.gg [CS_NEW] [WRONG_CALL_STATE]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_HANGUP (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:844 (sofia/external/+17549717866@fl.gg) Callstate Change DOWN -> HANGUP
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+17549717866@fl.gg) State HANGUP
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] mod_sofia.c:468 Channel sofia/external/+17549717866@fl.gg hanging up, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:59 sofia/external/+17549717866@fl.gg Standard HANGUP, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+17549717866@fl.gg) State HANGUP going to sleep
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:616 (sofia/external/+17549717866@fl.gg) State Change CS_HANGUP -> CS_REPORTING
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_REPORTING (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+17549717866@fl.gg) State REPORTING
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:168 sofia/external/+17549717866@fl.gg Standard REPORTING, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+17549717866@fl.gg) State REPORTING going to sleep
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:607 (sofia/external/+17549717866@fl.gg) State Change CS_REPORTING -> CS_DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_session.c:1753 Session 4172 (sofia/external/+17549717866@fl.gg) Locked, Waiting on external entities
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_session.c:1771 Session 4172 (sofia/external/+17549717866@fl.gg) Ended
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_session.c:1775 Close Channel sofia/external/+17549717866@fl.gg [CS_DESTROY]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:735 (sofia/external/+17549717866@fl.gg) Running State Change CS_DESTROY (Cur 0 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+17549717866@fl.gg) State DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] mod_sofia.c:379 sofia/external/+17549717866@fl.gg SOFIA DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:175 sofia/external/+17549717866@fl.gg Standard DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+17549717866@fl.gg) State DESTROY going to sleep
2022-04-06 11:29:58.423059 99.80% [DEBUG] sofia_reg.c:2665 Changing expire time to 579 by request of proxy sip:us-east-va.sip.flowroute.com
2022-04-06 11:30:19.283058 99.80% [DEBUG] sofia_reg.c:2665 Changing expire time to 558 by request of proxy sip:us-east-va.sip.flowroute.com
TCP DUMP
No. Time Source Destination Protocol Length Info
607 1.072849 78.138.127.110 96.64.180.250 SIP/SDP 1248 Request: INVITE sip:6498899893@96.64.180.250:5060 |
612 1.074865 96.64.180.250 78.138.127.110 SIP 870 Status: 407 Proxy Authentication Required |
747 1.203072 78.138.127.110 96.64.180.250 SIP 703 Request: ACK sip:6498899893@96.64.180.250 |
842 1.409984 34.226.36.35 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
843 1.411025 96.64.180.250 34.226.36.35 SIP 880 Status: 200 OK (OPTIONS) |
844 1.411595 34.226.36.34 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
845 1.411752 34.226.36.33 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
846 1.412471 96.64.180.250 34.226.36.34 SIP 880 Status: 200 OK (OPTIONS) |
847 1.412603 96.64.180.250 34.226.36.33 SIP 880 Status: 200 OK (OPTIONS) |
848 1.413808 34.226.36.32 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
Attached is the complete trace
THANK YOU!
MANNY
I am having problems with calls from PTSN to Voip Client..
The originating caller receives a fast busy..
Calls from VOIP Client to PTSN DO WORK and calls between extensions DO WORK PROPERLY...
Problem are with external calls to VOIP Client.
Using FLOW ROUTE as provider....
Number being called is +1-786-991-9204
This the FreeSwtich Log...
2022-04-06 11:26:05.243056 99.73% [DEBUG] sofia_reg.c:2665 Changing expire time to 298 by request of proxy sip:us-east-va.sip.flowroute.com
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [NOTICE] switch_channel.c:1123 New Channel sofia/external/+17549717866@fl.gg [7856c4e7-39e0-43a1-b670-e8d3c2424fbc]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_NEW (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [INFO] sofia.c:10462 sofia/external/+17549717866@fl.gg receiving invite from 34.226.36.32:5060 version: 1.10.7 -release 64bit call-id: 4725772_58319130@207.223.78.224
2022-04-06 11:28:07.623060 99.90% [DEBUG] sofia.c:10556 verifying acl "domains" for ip/port 34.226.36.32:0.
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:07.623060 99.90% [DEBUG] switch_core_state_machine.c:600 (sofia/external/+17549717866@fl.gg) State NEW
2022-04-06 11:28:07.623060 99.90% [DEBUG] sofia.c:2419 detaching session 7856c4e7-39e0-43a1-b670-e8d3c2424fbc
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [WARNING] switch_core_state_machine.c:684 7856c4e7-39e0-43a1-b670-e8d3c2424fbc sofia/external/+17549717866@fl.gg Abandoned
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/external/+17549717866@fl.gg [CS_NEW] [WRONG_CALL_STATE]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_HANGUP (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:844 (sofia/external/+17549717866@fl.gg) Callstate Change DOWN -> HANGUP
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+17549717866@fl.gg) State HANGUP
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] mod_sofia.c:468 Channel sofia/external/+17549717866@fl.gg hanging up, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:59 sofia/external/+17549717866@fl.gg Standard HANGUP, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/external/+17549717866@fl.gg) State HANGUP going to sleep
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:616 (sofia/external/+17549717866@fl.gg) State Change CS_HANGUP -> CS_REPORTING
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/external/+17549717866@fl.gg) Running State Change CS_REPORTING (Cur 1 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+17549717866@fl.gg) State REPORTING
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:168 sofia/external/+17549717866@fl.gg Standard REPORTING, cause: WRONG_CALL_STATE
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/external/+17549717866@fl.gg) State REPORTING going to sleep
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:607 (sofia/external/+17549717866@fl.gg) State Change CS_REPORTING -> CS_DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_session.c:1753 Session 4172 (sofia/external/+17549717866@fl.gg) Locked, Waiting on external entities
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_session.c:1771 Session 4172 (sofia/external/+17549717866@fl.gg) Ended
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [NOTICE] switch_core_session.c:1775 Close Channel sofia/external/+17549717866@fl.gg [CS_DESTROY]
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:735 (sofia/external/+17549717866@fl.gg) Running State Change CS_DESTROY (Cur 0 Tot 4172)
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+17549717866@fl.gg) State DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] mod_sofia.c:379 sofia/external/+17549717866@fl.gg SOFIA DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:175 sofia/external/+17549717866@fl.gg Standard DESTROY
7856c4e7-39e0-43a1-b670-e8d3c2424fbc 2022-04-06 11:28:17.643058 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/external/+17549717866@fl.gg) State DESTROY going to sleep
2022-04-06 11:29:58.423059 99.80% [DEBUG] sofia_reg.c:2665 Changing expire time to 579 by request of proxy sip:us-east-va.sip.flowroute.com
2022-04-06 11:30:19.283058 99.80% [DEBUG] sofia_reg.c:2665 Changing expire time to 558 by request of proxy sip:us-east-va.sip.flowroute.com
TCP DUMP
No. Time Source Destination Protocol Length Info
607 1.072849 78.138.127.110 96.64.180.250 SIP/SDP 1248 Request: INVITE sip:6498899893@96.64.180.250:5060 |
612 1.074865 96.64.180.250 78.138.127.110 SIP 870 Status: 407 Proxy Authentication Required |
747 1.203072 78.138.127.110 96.64.180.250 SIP 703 Request: ACK sip:6498899893@96.64.180.250 |
842 1.409984 34.226.36.35 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
843 1.411025 96.64.180.250 34.226.36.35 SIP 880 Status: 200 OK (OPTIONS) |
844 1.411595 34.226.36.34 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
845 1.411752 34.226.36.33 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
846 1.412471 96.64.180.250 34.226.36.34 SIP 880 Status: 200 OK (OPTIONS) |
847 1.412603 96.64.180.250 34.226.36.33 SIP 880 Status: 200 OK (OPTIONS) |
848 1.413808 34.226.36.32 96.64.180.250 SIP 738 Request: OPTIONS sip:gw+bb38dc45-3d0c-4114-95b1-d7a830589374@96.64.180.250:5080;transport=udp;gw=bb38dc45-3d0c-4114-95b1-d7a830589374 |
Attached is the complete trace
THANK YOU!
MANNY