FreePBX 15.0.16.44 + X-Lite 5.8.3 - Call On Hold issues

FreePBX Endpoints
1

Hey folks,

I am new to both FreePBX and X-Lite, so pls excuse my ignorance.
I got basic functionality working, and can call from one X-Lite client to the other.
However, I have an issue with trying to place a call On Hold.
The Pause Button in X-Lite gets disabled, and call status does not change, and I don’ thear the music ont he other side, and after a few seconds the call is dropped.

I found below in the Asterix logs, but have no clue how to proceed…

[2020-03-03 12:34:21] VERBOSE[19835][C-0000000e] res_musiconhold.c: Started music on hold, class 'default', on channel 'PJSIP/4141-00000016'
[2020-03-03 12:34:21] VERBOSE[9203] netsock2.c: Using SIP RTP Audio TOS bits 184
[2020-03-03 12:34:21] VERBOSE[9203] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2020-03-03 12:34:21] VERBOSE[9203] netsock2.c: Using SIP RTP Audio CoS mark 5
[2020-03-03 12:34:21] VERBOSE[19835][C-0000000e] app_dial.c: Connected line update to PJSIP/4141-00000016 prevented.
[2020-03-03 12:34:21] VERBOSE[19835][C-0000000e] app_dial.c: PJSIP/4020-00000017 is ringing
[2020-03-03 12:34:21] VERBOSE[19835][C-0000000e] app_dial.c: PJSIP/4020-00000017 is ringing
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] app_dial.c: PJSIP/4020-00000017 answered PJSIP/4141-00000016

[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:1] Set("PJSIP/4020-00000017", "__MACRO_RESULT=") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:2] Set("PJSIP/4020-00000017", "CFIGNORE=") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:3] Set("PJSIP/4020-00000017", "MASTER_CHANNEL(CFIGNORE)=") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:4] Set("PJSIP/4020-00000017", "FORWARD_CONTEXT=from-internal") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:5] Set("PJSIP/4020-00000017", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("PJSIP/4020-00000017", "blkvm-clr,") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-blkvm-clr:1] Set("PJSIP/4020-00000017", "SHARED(BLKVM,PJSIP/4141-00000016)=") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-blkvm-clr:2] Set("PJSIP/4020-00000017", "GOSUB_RETVAL=") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("PJSIP/4020-00000017", "") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("PJSIP/4020-00000017", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=4020/sip:[email protected]:56101;rinstance=183a9292a5d1ca82)") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("PJSIP/4020-00000017", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] res_musiconhold.c: Stopped music on hold on PJSIP/4141-00000016
[2020-03-03 12:34:30] VERBOSE[19841][C-0000000e] bridge_channel.c: Channel PJSIP/4020-00000017 joined 'simple_bridge' basic-bridge <aa3accb0-de8e-4d21-ba91-42ffc24e224c>
[2020-03-03 12:34:30] VERBOSE[19835][C-0000000e] bridge_channel.c: Channel PJSIP/4141-00000016 joined 'simple_bridge' basic-bridge <aa3accb0-de8e-4d21-ba91-42ffc24e224c>
[2020-03-03 12:35:02] VERBOSE[19835][C-0000000e] bridge_channel.c: Channel PJSIP/4141-00000016 left 'simple_bridge' basic-bridge <aa3accb0-de8e-4d21-ba91-42ffc24e224c>
[2020-03-03 12:35:02] VERBOSE[19835][C-0000000e] app_macro.c: Spawn extension (macro-dial, s, 25) exited non-zero on 'PJSIP/4141-00000016' in macro 'dial'
[2020-03-03 12:35:02] VERBOSE[19835][C-0000000e] pbx.c: Spawn extension (followme-sub, 4020, 40) exited non-zero on 'PJSIP/4141-00000016'
[2020-03-03 12:35:02] VERBOSE[19841][C-0000000e] bridge_channel.c: Channel PJSIP/4020-00000017 left 'simple_bridge' basic-bridge <aa3accb0-de8e-4d21-ba91-42ffc24e224c>

Any help will be greatly appreciated

2

Anyone?

3

You’d need to provide the SIP trace to show the actual traffic and what is going on. It can be output to the console using “pjsip set logger on”.

4

Hope this helps?

[2020-03-16 14:20:48] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141 @ sip.complab.eng>;tag=78468001
To: <sip:4020 @ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020 @ doma>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

5

You need to provide a complete SIP trace, not a single SIP response. That just shows me that a call was answered.

6

Here’s all I found in the log after enabling that option

Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip: [email protected]>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:20:44] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:20:48] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:20:52] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:20:56] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:20:58] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (481 bytes) to UDP:172.30.2.19:64364 —>
OPTIONS sip:[email protected]:64364;rinstance=3551ce835cd99f1a SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj4b746e1e-219c-43f1-810b-9e1affbd4fed
From: <sip:4020@ 172.30.254.68>;tag=95920e34-2e31-4958-bfe9-1befd880be90
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>
Contact: <sip:4020@ 104.145.12.182:5060>
Call-ID: fb3cec1a-d94c-435b-869e-7fe11be9faa2
CSeq: 3199 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Length: 0

[2020-03-16 14:20:58] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (626 bytes) from UDP:172.30.2.19:64364 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj4b746e1e-219c-43f1-810b-9e1affbd4fed;received=172.30.2.100
Contact: <sip: 10.10.10.19:64364>
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>;tag=eecfd219
From: <sip:4020@ 172.30.254.68>;tag=95920e34-2e31-4958-bfe9-1befd880be90
Call-ID: fb3cec1a-d94c-435b-869e-7fe11be9faa2
CSeq: 3199 OPTIONS
Accept: application/sdp
Accept-Language: en
Allow: OPTIONS, SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: X-Lite release 5.8.3 stamp 102651
Allow-Events: talk, hold
Content-Length: 0

[2020-03-16 14:21:00] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:21:02] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (679 bytes) to UDP:172.30.2.19:64364 —>
NOTIFY sip:[email protected]:64364 SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPjeeeba4bd-ec45-4279-896c-115a46f88d60
From: <sip:4020@ sip.complab.eng>;tag=d5b22d7d-4b9f-45f2-8bde-0774a91bdcc3
To: “Jody S” <sip:4020@ sip.complab.eng>;tag=3352dc6a
Contact: <sip: 104.145.12.182:5060>
Call-ID: 102651Mjk0Y2MxZDlkOTcwMGU4MjNlMjVhMWY3YTA4ZTIwODg
CSeq: 16863 NOTIFY
Event: message-summary
Subscription-State: terminated
Allow-Events: presence, dialog, message-summary, refer
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Type: application/simple-message-summary
Content-Length: 48

Messages-Waiting: no
Voice-Message: 0/0 (0/0)

[2020-03-16 14:21:02] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (693 bytes) to UDP:172.30.2.19:64364 —>
NOTIFY sip:[email protected]:64364;rinstance=3551ce835cd99f1a SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj188de78c-375a-48cf-88aa-09ad86979c4a
From: <sip:4020@ 172.30.254.68>;tag=503292a3-4ad8-4450-8b25-77d429d56e70
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>
Contact: <sip:4020@ 104.145.12.182:5060>
Call-ID: 700060a1-9de5-4050-9dda-655d46f510f2
CSeq: 42322 NOTIFY
Subscription-State: terminated
Event: message-summary
Allow-Events: presence, dialog, message-summary, refer
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Type: application/simple-message-summary
Content-Length: 48

Messages-Waiting: no
Voice-Message: 0/0 (0/0)

[2020-03-16 14:21:02] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (459 bytes) from UDP:172.30.2.19:64364 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPjeeeba4bd-ec45-4279-896c-115a46f88d60;received=172.30.2.100
Contact: <sip:4020@ 10.10.10.19:64364>
To: “Jody S”<sip:4020@ sip.complab.eng>;tag=3352dc6a
From: <sip:4020@ sip.complab.eng>;tag=d5b22d7d-4b9f-45f2-8bde-0774a91bdcc3
Call-ID: 102651Mjk0Y2MxZDlkOTcwMGU4MjNlMjVhMWY3YTA4ZTIwODg
CSeq: 16863 NOTIFY
User-Agent: X-Lite release 5.8.3 stamp 102651
Content-Length: 0

[2020-03-16 14:21:02] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (450 bytes) from UDP:172.30.2.19:64364 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj188de78c-375a-48cf-88aa-09ad86979c4a;received=172.30.2.100
Contact: <sip: 10.10.10.19:64364>
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>;tag=243d7513
From: <sip:4020@ 172.30.254.68>;tag=503292a3-4ad8-4450-8b25-77d429d56e70
Call-ID: 700060a1-9de5-4050-9dda-655d46f510f2
CSeq: 42322 NOTIFY
User-Agent: X-Lite release 5.8.3 stamp 102651
Content-Length: 0

[2020-03-16 14:21:04] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:21:08] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (488 bytes) to UDP:172.30.200.204:51781 —>
OPTIONS sip:4141@ 172.30.200.204:51781;rinstance=09786034c2cc74aa SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj354f8edc-b8a3-4e35-ba67-078d30f73778
From: <sip:4141@ 172.30.254.68>;tag=babc991e-2503-4de1-a7f6-36f147da7453
To: <sip:4141@ 172.30.200.204;rinstance=09786034c2cc74aa>
Contact: <sip:4141@ 104.145.12.182:5060>
Call-ID: 9d7d242e-90f2-4d37-9a72-e36b073ed18f
CSeq: 10391 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Length: 0

[2020-03-16 14:21:08] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (633 bytes) from UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj354f8edc-b8a3-4e35-ba67-078d30f73778;received=172.30.2.100
Contact: <sip: 172.30.200.204:51781>
To: <sip:4141@ 172.30.200.204;rinstance=09786034c2cc74aa>;tag=159b3831
From: <sip:4141@ 172.30.254.68>;tag=babc991e-2503-4de1-a7f6-36f147da7453
Call-ID: 9d7d242e-90f2-4d37-9a72-e36b073ed18f
CSeq: 10391 OPTIONS
Accept: application/sdp
Accept-Language: en
Allow: OPTIONS, SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: X-Lite release 5.8.3 stamp 102651
Allow-Events: talk, hold
Content-Length: 0

[2020-03-16 14:21:08] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody Spoor(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:21:12] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP response (1097 bytes) to UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.30.200.204:51781;rport=51781;received=172.30.200.204;branch=z9hG4bK-524287-1—95497b3d224e2168
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
From: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
To: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
CSeq: 2 INVITE
Server: FPBX-15.0.16.44(16.6.2)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip: 104.145.12.182:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: “Jody S(Available)” <sip:4020@ sip.complab.eng>
Content-Type: application/sdp
Content-Length: 398

v=0
o=- 3463730823 3 IN IP4 104.145.12.182
s=Asterisk
c=IN IP4 104.145.12.182
t=0 0
m=audio 17918 RTP/AVP 0 8 9 84 120 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:84 speex/16000
a=rtpmap:120 opus/48000/2
a=fmtp:120 maxaveragebitrate=64000;useinbandfec=1;usedtx=1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:20
a=sendrecv

[2020-03-16 14:21:13] VERBOSE[11817] res_pjsip_logger.c: <— Transmitting SIP request (426 bytes) to UDP:172.30.200.204:51781 —>
BYE sip:[email protected]:51781 SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj73d1d40a-117b-4de7-becd-a3d263d6b7ac
From: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
To: “Kona User” <sip:4141@ sip.complab.eng>;tag=78468001
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
CSeq: 25718 BYE
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Length: 0

[2020-03-16 14:21:13] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (458 bytes) from UDP:172.30.200.204:51781 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj73d1d40a-117b-4de7-becd-a3d263d6b7ac;received=172.30.2.100
Contact: <sip:4141@ 172.30.200.204:51781>
To: “Kona User”<sip:4141@ sip.complab.eng>;tag=78468001
From: <sip:4020@ sip.complab.eng>;tag=5b5ce1ef-f5ba-41c2-b155-f9fa742c988d
Call-ID: 102651YmVhYTE3Y2Y1OGZiNWY2ZGI1ZDBlZTk3NGM4NzJjZDE
CSeq: 25718 BYE
User-Agent: X-Lite release 5.8.3 stamp 102651
Content-Length: 0

[2020-03-16 14:21:13] VERBOSE[29332][C-00000014] bridge_channel.c: Channel PJSIP/4141-00000021 left ‘simple_bridge’ basic-bridge <5267b603-9f1c-4aa3-bf58-57a81b928cf2>
[2020-03-16 14:21:13] VERBOSE[29332][C-00000014] app_macro.c: Spawn extension (macro-dial, s, 25) exited non-zero on ‘PJSIP/4141-00000021’ in macro ‘dial’
[2020-03-16 14:21:13] VERBOSE[29332][C-00000014] pbx.c: Spawn extension (followme-sub, 4020, 40) exited non-zero on ‘PJSIP/4141-00000021’
[2020-03-16 14:21:13] VERBOSE[29335][C-00000014] bridge_channel.c: Channel PJSIP/4020-00000022 left ‘simple_bridge’ basic-bridge <5267b603-9f1c-4aa3-bf58-57a81b928cf2>
[2020-03-16 14:21:13] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (455 bytes) to UDP:172.30.2.19:64364 —>
BYE sip:[email protected]:64364 SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj6827619f-c7d7-4c3b-93e8-bf5dd59458a1
From: “Kona User” <sip:4141@ 172.30.254.68>;tag=33fc6b80-2836-4bd1-a5e0-14dab10af5ee
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>;tag=13569b27
Call-ID: a13f3019-768b-40f7-bdf4-8747a7e05dd8
CSeq: 14665 BYE
Reason: Q.850;cause=16
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Length: 0

[2020-03-16 14:21:13] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (464 bytes) from UDP:172.30.2.19:64364 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj6827619f-c7d7-4c3b-93e8-bf5dd59458a1;received=172.30.2.100
Contact: <sip:4020@ 10.10.10.19:64364>
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>;tag=13569b27
From: “Kona User” <sip:4141@ 172.30.254.68>;tag=33fc6b80-2836-4bd1-a5e0-14dab10af5ee
Call-ID: a13f3019-768b-40f7-bdf4-8747a7e05dd8
CSeq: 14665 BYE
User-Agent: X-Lite release 5.8.3 stamp 102651
Content-Length: 0

[2020-03-16 14:21:58] VERBOSE[28619] res_pjsip_logger.c: <— Transmitting SIP request (482 bytes) to UDP:172.30.2.19:64364 —>
OPTIONS sip:[email protected]:64364;rinstance=3551ce835cd99f1a SIP/2.0
Via: SIP/2.0/UDP 104.145.12.182:5060;rport;branch=z9hG4bKPj6a18696e-d658-4c8f-a52d-07db1fbfef36
From: <sip:4020@ 172.30.254.68>;tag=adb14aed-98d0-4486-b8ee-3a97d62792f4
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>
Contact: <sip:4020@ 104.145.12.182:5060>
Call-ID: bd08c6b9-0c27-4bd9-865c-9423bbe2f936
CSeq: 24474 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.16.44(16.6.2)
Content-Length: 0

[2020-03-16 14:21:58] VERBOSE[11817] res_pjsip_logger.c: <— Received SIP response (627 bytes) from UDP:172.30.2.19:64364 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 104.145.12.182:5060;rport=5060;branch=z9hG4bKPj6a18696e-d658-4c8f-a52d-07db1fbfef36;received=172.30.2.100
Contact: <sip: 10.10.10.19:64364>
To: <sip:4020@ 172.30.2.19;rinstance=3551ce835cd99f1a>;tag=080c1903
From: <sip:4020@ 172.30.254.68>;tag=adb14aed-98d0-4486-b8ee-3a97d62792f4
Call-ID: bd08c6b9-0c27-4bd9-865c-9423bbe2f936
CSeq: 24474 OPTIONS
Accept: application/sdp
Accept-Language: en
Allow: OPTIONS, SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: X-Lite release 5.8.3 stamp 102651
Allow-Events: talk, hold
Content-Length: 0

7

While scrubbing this, I noticed smthn myself…

  1. I see a 10.10.10.19 IP, which is a secondary IP on my desktop
  2. I see a 104.145.12.182 public IP, this not a known IP address to me?

The PBX and X-Lite client are in the same lan

8

The 200 OK has that public IP address, so the remote endpoint is likely sending the ACK to it. Since that is never received the call eventually hangs up. You’d need to double check configuration.

9

Any idea where that public IP would come from?
I just looked in the config of freepbx, the only public IP I can find is a real public IP.
That 104.145.12.182 is not known to me.

If I google that address I find this though
https://wiki.freepbx.org/display/SBC/Standard+SIPStation+Configuration
Is this an IP that’s hardcoded or used as default?

10

I don’t work on FreePBX so I can’t comment on that. Within Asterisk, which FreePBX configures, it is a configurable value.

11

Many thanx, at least I have a lead now what to look for :slight_smile:

12

After setting proper “public IPs” on all settings I could find, and rebooting the system, music on hold now works

Many thanx

13

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.