PGX
(Pgx)
November 16, 2017, 10:10am
1
Hello,
I am trying to set up new instalation of FreePBX.
I had problem with registration of SIP account on old one so I have decided to install new fresh one. Everything works besides incoming call to one SIP account.
I have two providers of SIP account one is fonet.dk and second is easycall.pl .
Fonet.dk is working fine. I can receive and make calls from this sip. But I have problem with second provider. I can only place calls but when I will call on this SIP it is not working.
Here is what I get when the call is incoming:
2017-11-16 10:41:25] DEBUG[1756] chan_sip.c: Target address 185.140.24.34:5060 is not local, substituting externaddr
[2017-11-16 10:41:25] DEBUG[1756] chan_sip.c: Allocating new SIP dialog for 2f[…][email protected] :5060 - INVITE (No RTP)
[2017-11-16 10:41:25] DEBUG[1756][C-00000014] chan_sip.c: Stopping retransmission on ‘2f[…][email protected] :5060’ of Response 102: Match Found
I was googling but notinh helped me. Any ideas where is the problem or how to debug more to find the issue?
posi211
(posi211 posi211)
November 16, 2017, 2:56pm
2
That’s not enough data.
what do you get when you run this from the CLI
show sip peers
Do you see both of your sip trunks?
PGX
(Pgx)
November 17, 2017, 7:18am
3
Yes, everything is fine. It is online - both of them.
“sip show registry” also show that the sip is “Registered”.
posi211
(posi211 posi211)
November 17, 2017, 10:21am
4
you could run tcpdump - nn qt -S -s 0 -A -vvv -i eth0 port 5060
can see if the packets are getting to your Asterisk server.
Did you try fwconsole stop firewall
to see if the firewall is causing your troubles.
PGX
(Pgx)
November 20, 2017, 10:38am
5
Hello,
I have taken tcp dumps and there are UDPpackets coming when I call to my number.
And also I tried to turn off firewall like you tols me and still no ringing on my site. The end device(IP Phone) is working because I can call from this one.
PGX
(Pgx)
November 22, 2017, 10:38am
6
Any advice? Still cannot solve the issue
PitzKey
(Itzik)
November 22, 2017, 10:55am
7
Since you mentioned that the problem is with one provider only, then look at your Trunk config.
Also, you might want to reach out for their support.
cynjut
(Dave Burgess)
November 22, 2017, 3:01pm
8
The log file /var/log/asterisk/full might have some information about why the calls are being rejected.
PGX
(Pgx)
November 23, 2017, 7:23am
9
Unfortunately, the support said that the trunk configuration is correct and they cannot help because they do not provide help for this solution. They only told me to check the dial plan but I have the inbound rout set up.
Second this is that in logs I have only this when I call to my number:
[2017-11-23 08:16:52] DEBUG[9645] manager.c: Running action ‘Login’
[2017-11-23 08:16:53] DEBUG[9645] manager.c: Running action ‘DPMALicenseStatus’
[2017-11-23 08:16:56] DEBUG[9650] manager.c: Running action ‘Login’
[2017-11-23 08:16:56] DEBUG[9650] manager.c: Running action ‘DPMALicenseStatus’
[2017-11-23 08:17:01] DEBUG[9668] manager.c: Running action ‘Login’
[2017-11-23 08:17:01] DEBUG[9669] manager.c: Running action ‘Login’
[2017-11-23 08:17:01] DEBUG[9670] manager.c: Running action ‘Login’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:04] DEBUG[9669] manager.c: Running action ‘Command’
[2017-11-23 08:17:06] DEBUG[9709] manager.c: Running action ‘Login’
[2017-11-23 08:17:06] DEBUG[9709] manager.c: Running action ‘DPMALicenseStatus’
[2017-11-23 08:17:06] DEBUG[1811] chan_sip.c: Target address 185.140.24.34:5060 is not local, substituting externaddr
[2017-11-23 08:17:06] DEBUG[1811] chan_sip.c: Allocating new SIP dialog for […]@185.140.24.49 :5060 - INVITE (No RTP)
[2017-11-23 08:17:06] DEBUG[1811][C-0000002a] chan_sip.c: Stopping retransmission on ‘[…]@185.140.24.49 :5060’ of Response 102: Match Found
[2017-11-23 08:17:07] DEBUG[9714] manager.c: Running action ‘Login’
[2017-11-23 08:17:07] DEBUG[9714] manager.c: Running action ‘DPMALicenseStatus’
PGX
(Pgx)
November 23, 2017, 1:43pm
10
I have installed also some old version of FreePBX and the same issue
PGX
(Pgx)
November 24, 2017, 9:08am
11
When I turn debug into deeper mode I receive:
[2017-11-24 09:55:34] DEBUG[1905] chan_sip.c: = Looking for Call ID: […]@185.140.24.49 :5060 (Checking From) --From tag as50a37536 --To-tag
[2017-11-24 09:55:34] DEBUG[1905] acl.c: For destination ‘185.140.24.34’, our source address is ‘192.168.1.133’.
[2017-11-24 09:55:34] DEBUG[1905] chan_sip.c: Target address 185.140.24.34:5060 is not local, substituting externaddr
[2017-11-24 09:55:34] DEBUG[1905] chan_sip.c: Setting SIP_TRANSPORT_UDP with address [ipaddress]:5060
[2017-11-24 09:55:34] DEBUG[1905] netsock2.c: Splitting ‘185.140.24.34’ into…
[2017-11-24 09:55:34] DEBUG[1905] netsock2.c: …host ‘185.140.24.34’ and port ‘’.
[2017-11-24 09:55:34] DEBUG[1905] chan_sip.c: Allocating new SIP dialog for […]@185.140.24.49 :5060 - INVITE (No RTP)
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] sip/reqresp_parser.c: Begin: parsing SIP “Supported: replaces, timer”
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] sip/reqresp_parser.c: Found SIP option: -replaces-
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] sip/reqresp_parser.c: Matched SIP option: replaces
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] sip/reqresp_parser.c: Found SIP option: -timer-
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] sip/reqresp_parser.c: Matched SIP option: timer
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] netsock2.c: Splitting ‘185.140.24.34’ into…
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] netsock2.c: …host ‘185.140.24.34’ and port ‘’.
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] netsock2.c: Splitting ‘185.140.24.49’ into…
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] netsock2.c: …host ‘185.140.24.49’ and port ‘’.
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] chan_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for 185.140.24.34:5060
[2017-11-24 09:55:34] DEBUG[1905] chan_sip.c: = Looking for Call ID: […]@185.140.24.49 :5060 (Checking From) --From tag as50a37536 --To-tag as4b915250
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
[2017-11-24 09:55:34] DEBUG[1905][C-0000001f] chan_sip.c: Stopping retransmission on ‘[…]@185.140.24.49 :5060’ of Response 102: Match Found
PGX
(Pgx)
November 27, 2017, 6:59am
13
Now I wonder. I can see here two addresses.
The SIP address that I am trying to connect is: sip.easycall.pl -> 185.140.24.34
But now what is this: 185.140.24.49
It also seems easycall but why does it pop up.
cynjut
(Dave Burgess)
November 27, 2017, 2:33pm
14
If your system is set up to accept calls from only 185.140.24.49, and 185.140.24.34 sends you a call, you’re going to get all sorts if interesting errors, since it’s an unknown source. You may need to add another trunk definition for the other inbound server.
PGX
(Pgx)
November 28, 2017, 10:47am
15
Still no success. No idea what is going on. Why it doesn’t for only for this provider
This is all I get. I configure SIP on address: sip.easycall.pl
[2017-11-28 11:43:44] DEBUG[1832] chan_sip.c: = Looking for Call ID: […]@185.140.24.49 :5060 (Checking From) --From tag as429ebf94 --To-tag
[2017-11-28 11:43:44] DEBUG[1832] acl.c: For destination ‘185.140.24.34’, our source address is ‘192.168.1.133’.
[2017-11-28 11:43:44] DEBUG[1832] chan_sip.c: Target address 185.140.24.34:5060 is not local, substituting externaddr
[2017-11-28 11:43:44] DEBUG[1832] chan_sip.c: Setting SIP_TRANSPORT_UDP with address […]:5060
[2017-11-28 11:43:44] DEBUG[1832] netsock2.c: Splitting ‘185.140.24.34’ into…
[2017-11-28 11:43:44] DEBUG[1832] netsock2.c: …host ‘185.140.24.34’ and port ‘’.
[2017-11-28 11:43:44] DEBUG[1832] chan_sip.c: Allocating new SIP dialog for […]@185.140.24.49 :5060 - INVITE (No RTP)
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] sip/reqresp_parser.c: Begin: parsing SIP “Supported: replaces, timer”
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] sip/reqresp_parser.c: Found SIP option: -replaces-
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] sip/reqresp_parser.c: Matched SIP option: replaces
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] sip/reqresp_parser.c: Found SIP option: -timer-
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] sip/reqresp_parser.c: Matched SIP option: timer
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] netsock2.c: Splitting ‘185.140.24.34’ into…
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] netsock2.c: …host ‘185.140.24.34’ and port ‘’.
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] netsock2.c: Splitting ‘185.140.24.49’ into…
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] netsock2.c: …host ‘185.140.24.49’ and port ‘’.
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] chan_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for 185.140.24.34:5060
[2017-11-28 11:43:44] DEBUG[1832] chan_sip.c: = Looking for Call ID: […]@185.140.24.49 :5060 (Checking From) --From tag as429ebf94 --To-tag as5f97ea2b
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] chan_sip.c: **** Received ACK (6) - Command in SIP ACK
[2017-11-28 11:43:44] DEBUG[1832][C-00000011] chan_sip.c: Stopping retransmission on ‘[…]@185.140.24.49 :5060’ of Response 102: Match Found