Hi,
So I have had an issue with FusionPBX pairing with my SIP Trunking Provider Lumen:
When I make an outbound call, it rings the phone, but when we answer it there is silence. Then when we hang it up, it rings the phone once again. The Caller ID is correct, but the actual call does not have any audio.
About Lumen:
Lumen is a Non-Reg, No Username or Password, IP Authentication Outbound/Inbound call Provider. They accept calls in E.164 and use RFC5806, RCF2833, and T.38 Fax.
Our Setup:
Currently for this installation, we have no Firewall except IpTables rules that come with FusionPBX. We also have an Allow on the Lumen IP Address. We are not firewalled upstream at all for the time being and therefore there is no NAT, there is a static ip we have set in External SIP and RTP IP section. We are coming over from Vitelity due to their recent reliability issues. I have enabled the Lumen IP Block in Access Control, and set it to allow.
I did a TCP Dump:
Then grabbed the Freeswitch Logs:
In our registration settings:
I have the Username and Password set to blank. The Proxy is set to the SIP Signaling IP they sent me with port 5060 after it, and register is set to false. Profile is set to External, and Enabled is set to true. For the rest of my providers everything is working normally.
Please let me know what we are doing wrong!
Thank You.
So I have had an issue with FusionPBX pairing with my SIP Trunking Provider Lumen:
When I make an outbound call, it rings the phone, but when we answer it there is silence. Then when we hang it up, it rings the phone once again. The Caller ID is correct, but the actual call does not have any audio.
About Lumen:
Lumen is a Non-Reg, No Username or Password, IP Authentication Outbound/Inbound call Provider. They accept calls in E.164 and use RFC5806, RCF2833, and T.38 Fax.
Our Setup:
Currently for this installation, we have no Firewall except IpTables rules that come with FusionPBX. We also have an Allow on the Lumen IP Address. We are not firewalled upstream at all for the time being and therefore there is no NAT, there is a static ip we have set in External SIP and RTP IP section. We are coming over from Vitelity due to their recent reliability issues. I have enabled the Lumen IP Block in Access Control, and set it to allow.
I did a TCP Dump:
Code:
root@server:~# tcpdump -i eno1 dst their.ip
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on eno1, link-type EN10MB (Ethernet), capture size 262144 bytes
13:31:11.128097 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:11.168493 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 341
13:31:12.128303 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:12.168211 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 341
13:31:14.128297 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:14.168393 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 341
13:31:18.129383 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:18.169458 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 341
13:31:18.214376 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:26.128927 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:26.169468 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:34.643714 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:35.142085 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:36.139120 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:38.139947 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:42.129376 IP my.domain.com.5080 > their.ip.sip: SIP: INVITE sip:cellnumber@their.ip SIP/2.0
13:31:42.133871 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:42.169444 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 556
13:31:46.137776 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 457
13:31:46.640698 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 457
13:31:47.636685 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 457
13:31:49.639247 IP my.domain.com > their.ip: ICMP my.domain.com udp port 5080 unreachable, length 457
^C
22 packets captured
23 packets received by filter
0 packets dropped by kernel
root@server:~# tcpdump -i eno1 src their.ip
tcpdump: verbose output suppressed, use -v or -vv for full protocol decode
listening on eno1, link-type EN10MB (Ethernet), capture size 262144 bytes
13:32:14.986852 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 100 Trying
13:32:15.987282 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 100 Trying
13:32:17.098914 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 180 Ringing
13:32:17.988294 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 180 Ringing
13:32:21.987720 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 180 Ringing
13:32:29.988485 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 180 Ringing
13:32:31.548621 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 200 OK
13:32:32.035967 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 200 OK
13:32:33.042204 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 200 OK
13:32:35.043291 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 200 OK
13:32:39.037322 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 200 OK
13:32:43.040983 IP their.ip.sip > my.domain.com.5080: SIP: BYE sip:gw+54816b7b-1e32-49a5-ba38-40c0849fcf2b@my.ip:5080;transport=udp;gw=54816b7b-1e32-49a5-ba38-40c0849fcf2b SIP/2.0
13:32:43.533975 IP their.ip.sip > my.domain.com.5080: SIP: BYE sip:gw+54816b7b-1e32-49a5-ba38-40c0849fcf2b@my.ip:5080;transport=udp;gw=54816b7b-1e32-49a5-ba38-40c0849fcf2b SIP/2.0
13:32:44.540088 IP their.ip.sip > my.domain.com.5080: SIP: BYE sip:gw+54816b7b-1e32-49a5-ba38-40c0849fcf2b@my.ip:5080;transport=udp;gw=54816b7b-1e32-49a5-ba38-40c0849fcf2b SIP/2.0
13:32:45.988000 IP their.ip.sip > my.domain.com.5080: SIP: SIP/2.0 481 Call Leg/Transaction Does Not Exist
13:32:46.542072 IP their.ip.sip > my.domain.com.5080: SIP: BYE sip:gw+54816b7b-1e32-49a5-ba38-40c0849fcf2b@my.ip:5080;transport=udp;gw=54816b7b-1e32-49a5-ba38-40c0849fcf2b SIP/2.0Then grabbed the Freeswitch Logs:
Code:
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [NOTICE] switch_channel.c:1118 New Channel sofia/external/cellnumber [f5bdc838-1613-46e7-a3f0-7f8bff688f83]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] mod_sofia.c:5102 (sofia/external/cellnumber) State Change CS_NEW -> CS_INIT
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:585 (sofia/external/cellnumber) Running State Change CS_INIT (Cur 4 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:628 (sofia/external/cellnumber) State INIT
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] mod_sofia.c:93 sofia/external/cellnumber SOFIA INIT
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] sofia_glue.c:1590 sip:8.48.173.13 Setting proxy route to sofia/external/cellnumber
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [INFO] sofia_glue.c:1621 sofia/external/cellnumber sending invite call-id: (null)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] sofia_glue.c:1624 sofia/external/cellnumber sending invite version: 1.10.6 -release-18-1ff9d0a60e 64bit
f5bdc838-1613-46e7-a3f0-7f8bff688f83 Local SDP:
f5bdc838-1613-46e7-a3f0-7f8bff688f83 v=0
f5bdc838-1613-46e7-a3f0-7f8bff688f83 o=FreeSWITCH 1637238760 1637238761 IN IP4 serverip
f5bdc838-1613-46e7-a3f0-7f8bff688f83 s=FreeSWITCH
f5bdc838-1613-46e7-a3f0-7f8bff688f83 c=IN IP4 cellnumber
f5bdc838-1613-46e7-a3f0-7f8bff688f83 t=0 0
f5bdc838-1613-46e7-a3f0-7f8bff688f83 m=audio 21060 RTP/AVP 9 0 8 101 13
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=rtpmap:9 G722/8000
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=rtpmap:0 PCMU/8000
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=rtpmap:8 PCMA/8000
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=rtpmap:101 telephone-event/8000
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=fmtp:101 0-16
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=rtpmap:13 CN/8000
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=ptime:20
f5bdc838-1613-46e7-a3f0-7f8bff688f83 a=sendrecv
f5bdc838-1613-46e7-a3f0-7f8bff688f83
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:40 sofia/external/cellnumber Standard INIT
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:48 (sofia/external/cellnumber) State Change CS_INIT -> CS_ROUTING
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:628 (sofia/external/cellnumber) State INIT going to sleep
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:585 (sofia/external/cellnumber) Running State Change CS_ROUTING (Cur 4 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] sofia.c:7406 Channel sofia/external/cellnumber entering state [calling][0]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:644 (sofia/external/cellnumber) State ROUTING
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] mod_sofia.c:154 sofia/external/cellnumber SOFIA ROUTING
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_ivr_originate.c:67 (sofia/external/cellnumber) State Change CS_ROUTING -> CS_CONSUME_MEDIA
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:644 (sofia/external/cellnumber) State ROUTING going to sleep
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:585 (sofia/external/cellnumber) Running State Change CS_CONSUME_MEDIA (Cur 4 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:663 (sofia/external/cellnumber) State CONSUME_MEDIA
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:23:40.213400 [DEBUG] switch_core_state_machine.c:663 (sofia/external/cellnumber) State CONSUME_MEDIA going to sleep
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] sofia.c:7406 Channel sofia/external/cellnumber entering state [terminated][408]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [NOTICE] sofia.c:8641 Hangup sofia/external/cellnumber [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:585 (sofia/external/cellnumber) Running State Change CS_HANGUP (Cur 2 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:848 (sofia/external/cellnumber) Callstate Change DOWN -> HANGUP
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:850 (sofia/external/cellnumber) State HANGUP
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] mod_sofia.c:453 Channel sofia/external/cellnumber hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:60 sofia/external/cellnumber Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:850 (sofia/external/cellnumber) State HANGUP going to sleep
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:620 (sofia/external/cellnumber) State Change CS_HANGUP -> CS_REPORTING
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:585 (sofia/external/cellnumber) Running State Change CS_REPORTING (Cur 2 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:936 (sofia/external/cellnumber) State REPORTING
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:174 sofia/external/cellnumber Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:936 (sofia/external/cellnumber) State REPORTING going to sleep
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_state_machine.c:611 (sofia/external/cellnumber) State Change CS_REPORTING -> CS_DESTROY
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.233437 [DEBUG] switch_core_session.c:1736 Session 93 (sofia/external/cellnumber) Locked, Waiting on external entities
2acd5ed1-2f65-4122-b9a5-1b5c79d6cd4b 2021-11-18 12:24:12.253419 [DEBUG] switch_ivr_originate.c:4026 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [NOTICE] switch_core_session.c:1754 Session 93 (sofia/external/cellnumber) Ended
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [NOTICE] switch_core_session.c:1758 Close Channel sofia/external/cellnumber [CS_DESTROY]
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [DEBUG] switch_core_state_machine.c:739 (sofia/external/cellnumber) Running State Change CS_DESTROY (Cur 1 Tot 93)
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [DEBUG] switch_core_state_machine.c:749 (sofia/external/cellnumber) State DESTROY
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [DEBUG] mod_sofia.c:364 sofia/external/cellnumber SOFIA DESTROY
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [DEBUG] switch_core_state_machine.c:181 sofia/external/cellnumber Standard DESTROY
f5bdc838-1613-46e7-a3f0-7f8bff688f83 2021-11-18 12:24:12.253419 [DEBUG] switch_core_state_machine.c:749 (sofia/external/cellnumber) State DESTROY going to sleepIn our registration settings:
I have the Username and Password set to blank. The Proxy is set to the SIP Signaling IP they sent me with port 5060 after it, and register is set to false. Profile is set to External, and Enabled is set to true. For the rest of my providers everything is working normally.
Please let me know what we are doing wrong!
Thank You.
