488 Not Acceptable Here INCOMPATIBLE_DESTINATION when calling MicroSIP from SIP.JS
1,206 views
Skip to first unread message
Slava Glushenkov
Nov 2, 2021, 8:29:06 AM11/2/21
to SIP.js
Do you have any idea? I really need help.
I'm going to make alive this configuration:
SIP.JS(WebRTC, Google Chrome)[502 Ext] <-> WSS <-> FreeSwitch (fake IP, Letsencrypt wildcard certs) <-> SIP UDP <-> MicroSip Windows client.[500 Ext]
I can call FreeSwitch MOH (music on Hold) from both sides without problem.
When I triend to call MicroSip from SIP.JS I receive 488 Incomartible destination. Here is SIP.JS log:
Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Transport | Sending WebSocket message:
===================================
INVITE sip:5...@freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 5ar62j53vrfb.invalid;branch=z9hG4bK6292065
From: <sip:5...@freeswitch.2raco.com>;tag=s7piub9s9m
CSeq: 2 INVITE
Call-ID: kqagh2783uickr43honm
Max-Forwards: 70
Proxy-Authorization: Digest algorithm=MD5, username="502", realm="freeswitch.2raco.com", nonce="144be92d-f251-4719-9385-e42ef6cefa70", uri="sip:5...@freeswitch.2raco.com", response="f8dc3c72e4c03257db92079871b93d17", qop=auth, cnonce="s7t6pc64oe3j", nc=00000001
Contact: <sip:faj3...@5ar62j53vrfb.invalid;transport=ws;ob>
Allow: ACK,CANCEL,INVITE,MESSAGE,BYE,OPTIONS,INFO,NOTIFY,REFER
Supported: outbound
User-Agent: SIP.js/0.20.0
Content-Type: application/sdp
Content-Length: 2019
v=0
o=- 8414510276564929647 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 7a8440f4-daba-4cf1-8730-192c22cd9907
m=audio 10328 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 46.53.254.134
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 50211 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10328 typ srflx raddr 192.168.1.145 rport 50211 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:1JzW
a=ice-pwd:w7he89RkFWXyMrZb39edZFrG
a=ice-options:trickle
a=fingerprint:sha-256 13:9B:05:45:DB:2F:12:42:E4:16:E5:6E:34:27:E5:D6:1F:DB:61:0B:C1:47:33:6A:7E:94:5E:7C:65:C4:20:C4
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=sendrecv
a=msid:7a8440f4-daba-4cf1-8730-192c22cd9907 caaf64a9-46b3-4c0c-940b-a49eaac02f96
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=ssrc:2118081786 cname:D0ujmpx05hCgJt1o
a=ssrc:2118081786 msid:7a8440f4-daba-4cf1-8730-192c22cd9907 caaf64a9-46b3-4c0c-940b-a49eaac02f96
a=ssrc:2118081786 mslabel:7a8440f4-daba-4cf1-8730-192c22cd9907
a=ssrc:2118081786 label:caaf64a9-46b3-4c0c-940b-a49eaac02f96
sip-0.20.0.min.js:2 Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Transport | Received WebSocket text message:
SIP/2.0 100 Trying
Via: SIP/2.0/WSS 5ar62j53vrfb.invalid;branch=z9hG4bK6292065;received=192.168.1.145;rport=57679
From: <sip:5...@freeswitch.2raco.com>;tag=s7piub9s9m
Call-ID: kqagh2783uickr43honm
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Content-Length: 0
sip-0.20.0.min.js:2 Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Inviter | Inviter.onTrying
sip-0.20.0.min.js:2 Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Transport | Received WebSocket text message:
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/WSS 5ar62j53vrfb.invalid;branch=z9hG4bK6292065;received=192.168.1.145;rport=57679
Max-Forwards: 70
From: <sip:5...@freeswitch.2raco.com>;tag=s7piub9s9m
To: <sip:5...@freeswitch.2raco.com>;tag=vNtt337FBXUFD
Call-ID: kqagh2783uickr43honm
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Reason: Q.850;cause=88;text="INCOMPATIBLE_DESTINATION"
Content-Length: 0
Remote-Party-ID: "500" <sip:5...@freeswitch.2raco.com>;party=calling;privacy=off;screen=no
sip-0.20.0.min.js:2 Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Transport | Sending WebSocket message:
ACK sip:5...@freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 5ar62j53vrfb.invalid;branch=z9hG4bK6292065
To: <sip:5...@freeswitch.2raco.com>;tag=vNtt337FBXUFD
From: <sip:5...@freeswitch.2raco.com>;tag=s7piub9s9m
Call-ID: kqagh2783uickr43honm
CSeq: 2 ACK
Max-Forwards: 70
Content-Length: 0
sip-0.20.0.min.js:2 Tue Nov 02 2021 14:30:32 GMT+0300 (Moscow Standard Time) | sip.Inviter | Inviter.onReject
==========================================
FreeSwitch log:
==========================================
recv 663 bytes from wss/[192.168.1.145]:57679 at 15:14:34.461085:
------------------------------------------------------------------------
REGISTER sip:freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 5ar62j53vrfb.invalid;branch=z9hG4bK5364645
From: <sip:5...@freeswitch.2raco.com>;tag=v224jbb8jr
CSeq: 12 REGISTER
Call-ID: kqagh7ptru9a493nkn1q
Max-Forwards: 70
Authorization: Digest algorithm=MD5, username="502", realm="freeswitch.2raco.com", nonce="e7a8a331-4a95-48d9-8e4d-09ff7de01010", uri="sip:freeswitch.2raco.com", response="e703a7f18b627dcb68997b44b812a113", qop=auth, cnonce="l5ji8vnmscu5", nc=00000001
Contact: <sip:faj3...@5ar62j53vrfb.invalid;transport=ws>;expires=0
Supported: outbound, path, gruu
User-Agent: SIP.js/0.20.0
Content-Length: 0
recv 476 bytes from wss/[192.168.1.145]:53655 at 15:14:35.159015:
------------------------------------------------------------------------
REGISTER sip:freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK7139725
From: <sip:5...@freeswitch.2raco.com>;tag=lp0ns6ur33
CSeq: 2 REGISTER
Call-ID: 8c71s72i6mhdn0kinkr5
Max-Forwards: 70
Contact: <sip:5hng...@2h0gk33eajci.invalid;transport=ws>;expires=600
Allow: ACK,CANCEL,INVITE,MESSAGE,BYE,OPTIONS,INFO,NOTIFY,REFER
Supported: outbound, path, gruu
User-Agent: SIP.js/0.20.0
Content-Length: 0
send 609 bytes to wss/[192.168.1.145]:53655 at 15:14:35.160983:
------------------------------------------------------------------------
SIP/2.0 401 Unauthorized
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK7139725;received=192.168.1.145;rport=53655
From: <sip:5...@freeswitch.2raco.com>;tag=lp0ns6ur33
To: <sip:5...@freeswitch.2raco.com>;tag=9BcpK5Xe9D6rp
Call-ID: 8c71s72i6mhdn0kinkr5
CSeq: 2 REGISTER
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
WWW-Authenticate: Digest realm="freeswitch.2raco.com", nonce="06b00ed5-a372-43d9-b5b2-391617df2157", algorithm=MD5, qop="auth"
Content-Length: 0
recv 728 bytes from wss/[192.168.1.145]:53655 at 15:14:35.217136:
------------------------------------------------------------------------
REGISTER sip:freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK4908572
From: <sip:5...@freeswitch.2raco.com>;tag=lp0ns6ur33
CSeq: 3 REGISTER
Call-ID: 8c71s72i6mhdn0kinkr5
Max-Forwards: 70
Authorization: Digest algorithm=MD5, username="502", realm="freeswitch.2raco.com", nonce="06b00ed5-a372-43d9-b5b2-391617df2157", uri="sip:freeswitch.2raco.com", response="016e9923c7d99b195e94d99e70b1d995", qop=auth, cnonce="q95af2mfc3h1", nc=00000001
Contact: <sip:5hng...@2h0gk33eajci.invalid;transport=ws>;expires=600
Allow: ACK,CANCEL,INVITE,MESSAGE,BYE,OPTIONS,INFO,NOTIFY,REFER
Supported: outbound, path, gruu
User-Agent: SIP.js/0.20.0
Content-Length: 0
send 579 bytes to wss/[192.168.1.145]:53655 at 15:14:35.223989:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK4908572;received=192.168.1.145;rport=53655
From: <sip:5...@freeswitch.2raco.com>;tag=lp0ns6ur33
To: <sip:5...@freeswitch.2raco.com>;tag=aN5eN0ej6pvBj
Call-ID: 8c71s72i6mhdn0kinkr5
CSeq: 3 REGISTER
Contact: <sip:5hng...@2h0gk33eajci.invalid;transport=ws>;expires=600
Date: Tue, 02 Nov 2021 12:14:35 GMT
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Content-Length: 0
send 852 bytes to wss/[192.168.1.145]:53655 at 15:14:35.245887:
------------------------------------------------------------------------
NOTIFY sip:5hng...@2h0gk33eajci.invalid;transport=ws SIP/2.0
Via: SIP/2.0/WSS 192.168.1.15:7443;branch=z9hG4bKHF6pH67mDKcZr
Route: <sip:5hng...@192.168.1.145:53655>;transport=wss
Max-Forwards: 70
From: <sip:5...@freeswitch.2raco.com>;tag=Byy7pUZN3ZjyD
Call-ID: 48b90669-b679-123a-22b5-e840f2042452
CSeq: 43373845 NOTIFY
Contact: <sip:mod_...@192.168.1.15:5060>
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Event: message-summary
Allow-Events: talk, hold, conference, refer
Subscription-State: terminated;reason=noresource
Content-Type: application/simple-message-summary
Content-Length: 71
Messages-Waiting: no
Message-Account: sip:5...@freeswitch.2raco.com
recv 355 bytes from wss/[192.168.1.145]:53655 at 15:14:35.273477:
------------------------------------------------------------------------
SIP/2.0 481 Call/Transaction Does Not Exist
Via: SIP/2.0/WSS 192.168.1.15:7443;branch=z9hG4bKHF6pH67mDKcZr
From: <sip:5...@freeswitch.2raco.com>;tag=Byy7pUZN3ZjyD
To: <sip:5...@freeswitch.2raco.com>;tag=s1bkn9a7nt
CSeq: 43373845 NOTIFY
Call-ID: 48b90669-b679-123a-22b5-e840f2042452
Supported: outbound
User-Agent: SIP.js/0.20.0
Content-Length: 0
recv 2508 bytes from wss/[192.168.1.145]:53655 at 15:14:41.514070:
------------------------------------------------------------------------
INVITE sip:5...@freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK4950105
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
CSeq: 1 INVITE
Call-ID: 8c71son4b9qle65v4393
Max-Forwards: 70
Contact: <sip:5hng...@2h0gk33eajci.invalid;transport=ws;ob>
Allow: ACK,CANCEL,INVITE,MESSAGE,BYE,OPTIONS,INFO,NOTIFY,REFER
Supported: outbound
User-Agent: SIP.js/0.20.0
Content-Type: application/sdp
Content-Length: 2019
v=0
o=- 4316832843066277697 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 10408 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 46.53.254.134
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=sendrecv
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
24677760 2021-11-02 15:14:41.504715 98.83% [NOTICE] switch_channel.c:1123 New Channel sofia/internal/5...@freeswitch.2raco.com [24677760-eb36-43d8-b5fa-c7a06d9cf632]
24677760 2021-11-02 15:14:41.504715 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_NEW (Cur 1 Tot 9)
24677760 2021-11-02 15:14:41.504715 98.83% [INFO] sofia.c:10462 sofia/internal/5...@freeswitch.2raco.com receiving invite from 192.168.1.145:53655 version: 1.10.7 -release.13 64bit call-id: 8c71son4b9qle65v4393
24677760 2021-11-02 15:14:41.504715 98.83% [DEBUG] switch_core_state_machine.c:600 (sofia/internal/5...@freeswitch.2raco.com) State NEW
send 696 bytes to wss/[192.168.1.145]:53655 at 15:14:41.517814:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK4950105;received=192.168.1.145;rport=53655
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
To: <sip:5...@freeswitch.2raco.com>;tag=c7Q0rpgS088gS
Call-ID: 8c71son4b9qle65v4393
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Proxy-Authenticate: Digest realm="freeswitch.2raco.com", nonce="f6d7d078-a288-48cc-a0d6-4e23d4bde0de", algorithm=MD5, qop="auth"
Content-Length: 0
2021-11-02 15:14:41.504715 98.83% [DEBUG] sofia.c:2419 detaching session 24677760-eb36-43d8-b5fa-c7a06d9cf632
recv 293 bytes from wss/[192.168.1.145]:53655 at 15:14:41.544115:
------------------------------------------------------------------------
ACK sip:5...@freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK4950105
To: <sip:5...@freeswitch.2raco.com>;tag=c7Q0rpgS088gS
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
Call-ID: 8c71son4b9qle65v4393
CSeq: 1 ACK
Max-Forwards: 70
Content-Length: 0
recv 2770 bytes from wss/[192.168.1.145]:53655 at 15:14:41.546776:
------------------------------------------------------------------------
INVITE sip:5...@freeswitch.2raco.com SIP/2.0
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK8883040
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
CSeq: 2 INVITE
Call-ID: 8c71son4b9qle65v4393
Max-Forwards: 70
Proxy-Authorization: Digest algorithm=MD5, username="502", realm="freeswitch.2raco.com", nonce="f6d7d078-a288-48cc-a0d6-4e23d4bde0de", uri="sip:5...@freeswitch.2raco.com", response="7f60576d2aca20b073dc57eb95430d15", qop=auth, cnonce="k6fbfi491oel", nc=00000001
Contact: <sip:5hng...@2h0gk33eajci.invalid;transport=ws;ob>
Allow: ACK,CANCEL,INVITE,MESSAGE,BYE,OPTIONS,INFO,NOTIFY,REFER
Supported: outbound
User-Agent: SIP.js/0.20.0
Content-Type: application/sdp
Content-Length: 2019
v=0
o=- 4316832843066277697 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 10408 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 46.53.254.134
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=sendrecv
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
2021-11-02 15:14:41.544726 98.83% [DEBUG] sofia.c:2532 Re-attaching to session 24677760-eb36-43d8-b5fa-c7a06d9cf632
24677760 2021-11-02 15:14:41.544726 98.83% [INFO] sofia.c:10462 sofia/internal/5...@freeswitch.2raco.com receiving invite from 192.168.1.145:53655 version: 1.10.7 -release.13 64bit call-id: 8c71son4b9qle65v4393
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] sofia.c:11672 Setting NAT mode based on websockets
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] sofia.c:7499 Channel sofia/internal/5...@freeswitch.2raco.com entering state [received][100]
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] sofia.c:7509 Remote SDP:
v=0
o=- 4316832843066277697 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 10408 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 46.53.254.134
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] sofia.c:7906 (sofia/internal/5...@freeswitch.2raco.com) State Change CS_NEW -> CS_INIT
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_INIT (Cur 1 Tot 9)
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:624 (sofia/internal/5...@freeswitch.2raco.com) State INIT
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] mod_sofia.c:97 sofia/internal/5...@freeswitch.2raco.com SOFIA INIT
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:40 sofia/internal/5...@freeswitch.2raco.com Standard INIT
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5...@freeswitch.2raco.com) State Change CS_INIT -> CS_ROUTING
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:624 (sofia/internal/5...@freeswitch.2raco.com) State INIT going to sleep
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_ROUTING (Cur 1 Tot 9)
24677760 2021-11-02 15:14:41.544726 98.83% [DEBUG] switch_channel.c:2380 (sofia/internal/5...@freeswitch.2raco.com) Callstate Change DOWN -> RINGING
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5...@freeswitch.2raco.com) State ROUTING
send 331 bytes to wss/[192.168.1.145]:53655 at 15:14:41.565570:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK8883040;received=192.168.1.145;rport=53655
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
Call-ID: 8c71son4b9qle65v4393
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Content-Length: 0
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] mod_sofia.c:158 sofia/internal/5...@freeswitch.2raco.com SOFIA ROUTING
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:230 sofia/internal/5...@freeswitch.2raco.com Standard ROUTING
24677760 2021-11-02 15:14:41.564782 98.83% [INFO] mod_dialplan_xml.c:639 Processing 502 <502>->500 in context default
24677760 Dialplan: sofia/internal/5...@freeswitch.2raco.com parsing [default->500] continue=false
24677760 Dialplan: sofia/internal/5...@freeswitch.2raco.com Regex (PASS) [500] destination_number(500) =~ /^500$/ break=on-false
24677760 Dialplan: sofia/internal/5...@freeswitch.2raco.com Action bridge(user/500)
24677760 Dialplan: sofia/internal/5...@freeswitch.2raco.com Action hangup()
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:281 (sofia/internal/5...@freeswitch.2raco.com) State Change CS_ROUTING -> CS_EXECUTE
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5...@freeswitch.2raco.com) State ROUTING going to sleep
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_EXECUTE (Cur 1 Tot 9)
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:647 (sofia/internal/5...@freeswitch.2raco.com) State EXECUTE
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] mod_sofia.c:213 sofia/internal/5...@freeswitch.2raco.com SOFIA EXECUTE
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_core_state_machine.c:323 sofia/internal/5...@freeswitch.2raco.com Standard EXECUTE
24677760 EXECUTE [depth=0] sofia/internal/5...@freeswitch.2raco.com bridge(user/500)
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
24677760 2021-11-02 15:14:41.564782 98.83% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
61ee1ea9 2021-11-02 15:14:41.564782 98.83% [NOTICE] switch_channel.c:1123 New Channel sofia/internal/5...@192.168.1.145:54699 [61ee1ea9-a591-4cf1-909c-b33b1e67f97e]
61ee1ea9 2021-11-02 15:14:41.564782 98.83% [DEBUG] mod_sofia.c:5121 (sofia/internal/5...@192.168.1.145:54699) State Change CS_NEW -> CS_INIT
24677760 2021-11-02 15:14:41.584728 98.83% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@192.168.1.145:54699) Running State Change CS_INIT (Cur 2 Tot 10)
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:624 (sofia/internal/5...@192.168.1.145:54699) State INIT
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] mod_sofia.c:97 sofia/internal/5...@192.168.1.145:54699 SOFIA INIT
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_media.c:12454 sofia/internal/5...@192.168.1.145:54699 Patched SDP
---
v=0
o=- 4316832843066277697 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 10408 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 46.53.254.134
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
+++
v=0
o=FreeSWITCH 3842250326 3842250327 IN IP4 192.168.1.15
s=FreeSWITCH
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 30064 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 192.168.1.15
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [INFO] sofia_glue.c:1651 sofia/internal/5...@192.168.1.145:54699 sending invite call-id: (null)
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] sofia_glue.c:1654 sofia/internal/5...@192.168.1.145:54699 sending invite version: 1.10.7 -release.13 64bit
Local SDP:
v=0
o=FreeSWITCH 3842250326 3842250327 IN IP4 192.168.1.15
s=FreeSWITCH
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 30064 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 192.168.1.15
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
send 2835 bytes to udp/[192.168.1.145]:54699 at 15:14:41.597905:
------------------------------------------------------------------------
INVITE sip:5...@192.168.1.145:54699;ob SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15;rport;branch=z9hG4bKjrZFK1rrav2Hm
Max-Forwards: 69
From: "Extension 502" <sip:5...@freeswitch.2raco.com>;tag=eSajvcj0ttNpg
To: <sip:5...@192.168.1.145:54699;ob>
Call-ID: 4c82386d-b679-123a-22b5-e840f2042452
CSeq: 43373848 INVITE
Contact: <sip:mod_...@192.168.1.15:5060>
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 2027
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 502" <sip:5...@freeswitch.2raco.com>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 3842250326 3842250327 IN IP4 192.168.1.15
s=FreeSWITCH
t=0 0
a=group:BUNDLE 0
a=extmap-allow-mixed
a=msid-semantic: WMS 41c8c7c1-0c80-490e-ac83-3c77ea6074f2
m=audio 30064 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 192.168.1.15
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1912282794 1 udp 2122260223 192.168.1.145 59556 typ host generation 0 network-id 1
a=candidate:4038268958 1 udp 1686052607 46.53.254.134 10408 typ srflx raddr 192.168.1.145 rport 59556 generation 0 network-id 1
a=candidate:1064886874 1 tcp 1518280447 192.168.1.145 9 typ host tcptype active generation 0 network-id 1
a=ice-ufrag:0Bha
a=ice-pwd:8+eXD1vuj+k6FlEmD4j1RjWq
a=ice-options:trickle
a=fingerprint:sha-256 57:6E:B5:27:95:B7:EA:4F:27:DF:52:AE:00:B4:B9:27:22:E0:AE:86:5F:38:60:8B:B9:68:AB:26:54:EB:DB:22
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2322128342 cname:cTlZRm5NgHUCNNhx
a=ssrc:2322128342 msid:41c8c7c1-0c80-490e-ac83-3c77ea6074f2 18811052-dd46-472b-8553-266a5130d659
a=ssrc:2322128342 mslabel:41c8c7c1-0c80-490e-ac83-3c77ea6074f2
a=ssrc:2322128342 label:18811052-dd46-472b-8553-266a5130d659
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:40 sofia/internal/5...@192.168.1.145:54699 Standard INIT
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5...@192.168.1.145:54699) State Change CS_INIT -> CS_ROUTING
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:624 (sofia/internal/5...@192.168.1.145:54699) State INIT going to sleep
recv 358 bytes from udp/[192.168.1.145]:54699 at 15:14:41.599819:
------------------------------------------------------------------------
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/UDP 192.168.1.15;rport=5060;received=192.168.1.15;branch=z9hG4bKjrZFK1rrav2Hm
Call-ID: 4c82386d-b679-123a-22b5-e840f2042452
From: "Extension 502" <sip:5...@freeswitch.2raco.com>;tag=eSajvcj0ttNpg
To: <sip:5...@192.168.1.145;ob>;tag=b7de8f1de1e14c76b4ed883a90164dd2
CSeq: 43373848 INVITE
Content-Length: 0
send 356 bytes to udp/[192.168.1.145]:54699 at 15:14:41.600212:
------------------------------------------------------------------------
ACK sip:5...@192.168.1.145:54699;ob SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15;rport;branch=z9hG4bKjrZFK1rrav2Hm
Max-Forwards: 69
From: "Extension 502" <sip:5...@freeswitch.2raco.com>;tag=eSajvcj0ttNpg
To: <sip:5...@192.168.1.145;ob>;tag=b7de8f1de1e14c76b4ed883a90164dd2
Call-ID: 4c82386d-b679-123a-22b5-e840f2042452
CSeq: 43373848 ACK
Content-Length: 0
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@192.168.1.145:54699) Running State Change CS_ROUTING (Cur 2 Tot 10)
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] sofia.c:7499 Channel sofia/internal/5...@192.168.1.145:54699 entering state [calling][0]
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [DEBUG] sofia.c:7499 Channel sofia/internal/5...@192.168.1.145:54699 entering state [terminated][488]
61ee1ea9 2021-11-02 15:14:41.584728 98.83% [NOTICE] sofia.c:8738 Hangup sofia/internal/5...@192.168.1.145:54699 [CS_ROUTING] [INCOMPATIBLE_DESTINATION]
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5...@192.168.1.145:54699) State ROUTING
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] mod_sofia.c:158 sofia/internal/5...@192.168.1.145:54699 SOFIA ROUTING
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5...@192.168.1.145:54699) State ROUTING going to sleep
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@192.168.1.145:54699) Running State Change CS_HANGUP (Cur 2 Tot 10)
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:844 (sofia/internal/5...@192.168.1.145:54699) Callstate Change DOWN -> HANGUP
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/5...@192.168.1.145:54699) State HANGUP
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] mod_sofia.c:468 Channel sofia/internal/5...@192.168.1.145:54699 hanging up, cause: INCOMPATIBLE_DESTINATION
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:59 sofia/internal/5...@192.168.1.145:54699 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/5...@192.168.1.145:54699) State HANGUP going to sleep
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:616 (sofia/internal/5...@192.168.1.145:54699) State Change CS_HANGUP -> CS_REPORTING
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@192.168.1.145:54699) Running State Change CS_REPORTING (Cur 2 Tot 10)
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/5...@192.168.1.145:54699) State REPORTING
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:168 sofia/internal/5...@192.168.1.145:54699 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/5...@192.168.1.145:54699) State REPORTING going to sleep
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:607 (sofia/internal/5...@192.168.1.145:54699) State Change CS_REPORTING -> CS_DESTROY
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_session.c:1753 Session 10 (sofia/internal/5...@192.168.1.145:54699) Locked, Waiting on external entities
24677760 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [NOTICE] switch_core_session.c:1771 Session 10 (sofia/internal/5...@192.168.1.145:54699) Ended
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [NOTICE] switch_core_session.c:1775 Close Channel sofia/internal/5...@192.168.1.145:54699 [CS_DESTROY]
24677760 2021-11-02 15:14:41.604732 98.83% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [user] cause: [INCOMPATIBLE_DESTINATION]
24677760 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:735 (sofia/internal/5...@192.168.1.145:54699) Running State Change CS_DESTROY (Cur 1 Tot 10)
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/5...@192.168.1.145:54699) State DESTROY
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] mod_sofia.c:379 sofia/internal/5...@192.168.1.145:54699 SOFIA DESTROY
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:175 sofia/internal/5...@192.168.1.145:54699 Standard DESTROY
61ee1ea9 2021-11-02 15:14:41.604732 98.83% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/5...@192.168.1.145:54699) State DESTROY going to sleep
24677760 2021-11-02 15:14:41.604732 98.83% [INFO] mod_dptools.c:3653 Originate Failed. Cause: INCOMPATIBLE_DESTINATION
24677760 2021-11-02 15:14:41.604732 98.83% [NOTICE] switch_channel.c:5050 Hangup sofia/internal/5...@freeswitch.2raco.com [CS_EXECUTE] [INCOMPATIBLE_DESTINATION]
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_session.c:2983 sofia/internal/5...@freeswitch.2raco.com skip receive message [PHONE_EVENT] (channel is hungup already)
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:647 (sofia/internal/5...@freeswitch.2raco.com) State EXECUTE going to sleep
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_HANGUP (Cur 1 Tot 10)
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:844 (sofia/internal/5...@freeswitch.2raco.com) Callstate Change RINGING -> HANGUP
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/5...@freeswitch.2raco.com) State HANGUP
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] mod_sofia.c:462 sofia/internal/5...@freeswitch.2raco.com Overriding SIP cause 488 with 488 from the other leg
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] mod_sofia.c:468 Channel sofia/internal/5...@freeswitch.2raco.com hanging up, cause: INCOMPATIBLE_DESTINATION
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 488
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:59 sofia/internal/5...@freeswitch.2raco.com Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/5...@freeswitch.2raco.com) State HANGUP going to sleep
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:616 (sofia/internal/5...@freeswitch.2raco.com) State Change CS_HANGUP -> CS_REPORTING
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_REPORTING (Cur 1 Tot 10)
send 721 bytes to wss/[192.168.1.145]:53655 at 15:14:41.627904:
------------------------------------------------------------------------
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/WSS 2h0gk33eajci.invalid;branch=z9hG4bK8883040;received=192.168.1.145;rport=53655
Max-Forwards: 70
From: <sip:5...@freeswitch.2raco.com>;tag=is05l7c0du
To: <sip:5...@freeswitch.2raco.com>;tag=DgHStH1vXHZ3m
Call-ID: 8c71son4b9qle65v4393
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.10.7-release.13~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Reason: Q.850;cause=88;text="INCOMPATIBLE_DESTINATION"
Content-Length: 0
Remote-Party-ID: "500" <sip:5...@freeswitch.2raco.com>;party=calling;privacy=off;screen=no
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/5...@freeswitch.2raco.com) State REPORTING
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:168 sofia/internal/5...@freeswitch.2raco.com Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/5...@freeswitch.2raco.com) State REPORTING going to sleep
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:607 (sofia/internal/5...@freeswitch.2raco.com) State Change CS_REPORTING -> CS_DESTROY
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_session.c:1753 Session 9 (sofia/internal/5...@freeswitch.2raco.com) Locked, Waiting on external entities
24677760 2021-11-02 15:14:41.624781 98.83% [NOTICE] switch_core_session.c:1771 Session 9 (sofia/internal/5...@freeswitch.2raco.com) Ended
24677760 2021-11-02 15:14:41.624781 98.83% [NOTICE] switch_core_session.c:1775 Close Channel sofia/internal/5...@freeswitch.2raco.com [CS_DESTROY]
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:735 (sofia/internal/5...@freeswitch.2raco.com) Running State Change CS_DESTROY (Cur 0 Tot 10)
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/5...@freeswitch.2raco.com) State DESTROY
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] mod_sofia.c:379 sofia/internal/5...@freeswitch.2raco.com SOFIA DESTROY
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:175 sofia/internal/5...@freeswitch.2raco.com Standard DESTROY
24677760 2021-11-02 15:14:41.624781 98.83% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/5...@freeswitch.2raco.com) State DESTROY going to sleep
==========================================
Albert Diaz
Nov 8, 2021, 6:47:34 PM11/8/21
to SIP.js
That usually happens wen the receiving party doesn't support the codecs in your INVITE. Check that the receiving UA supports all the codecs in the INVITE of the calling UA.
Reply all
Reply to author
Forward
0 new messages