Sip sms not working

asterisk
configuration
bug
Tags: #<Tag:0x00007f4f4350dec8> #<Tag:0x00007f4f4350dd60> #<Tag:0x00007f4f4350dbf8>

(Rana hashem) #21
freepbx*CLI> sip set debug on

SIP Debugging enabled
Reliably Transmitting (no NAT) to 172.26.192.1:21444:
OPTIONS sip:104@172.26.192.1:21444 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK42a90785
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as3aa7f680
To: sip:104@172.26.192.1:21444
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


<— SIP read from UDP:192.168.1.152:12804 —>
MESSAGE sip:108@192.168.1.6 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.152:12804;rport;branch=z9hG4bK-173p387635179950466522 7r
From: “Rana” sip:106@192.168.1.6;tag=172g5652834765102849795m
To: sip:108@192.168.1.6
Call-ID: 170e6215132922025206960k72799rmwp
CSeq: 2604 MESSAGE
Max-Forwards: 70
Contact: “Rana” sip:106@192.168.1.152:12804
User-Agent: MizuDroid/3.4.1
Supported: replaces
Allow: ACK,PRACK,BYE,CANCEL,INVITE,UPDATE,MESSAGE,INFO,OPTIONS,SUBSCRIBE,NOTIFY, REFER
Allow-Events: presence,refer,telephone-event,keep-alive,dialog
Accept: application/sdp,application/dtmf-relay,text/plain
Content-Type: application/im-iscomposing+xml
Content-Length: 338

<?xml version="1.0" encoding="UTF-8"?>


active
text
60

<------------->
— (15 headers 9 lines) —
Sending to 192.168.1.152:12804 (no NAT)
Receiving message!

<— Transmitting (no NAT) to 192.168.1.152:12804 —>
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/UDP 192.168.1.152:12804;branch=z9hG4bK-173p3876351799504665227r;rec eived=192.168.1.152;rport=12804
From: “Rana” sip:106@192.168.1.6;tag=172g5652834765102849795m
To: sip:108@192.168.1.6;tag=as5cdd97ba
Call-ID: 170e6215132922025206960k72799rmwp
CSeq: 2604 MESSAGE
Server: FPBX-15.0.17.34(17.9.3)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘170e6215132922025206960k72799rmwp’ in 3200 0 ms (Method: MESSAGE)

<— SIP read from UDP:192.168.1.152:12804 —>
MESSAGE sip:108@192.168.1.6 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.152:12804;rport;branch=z9hG4bK-177p955748942511667906 r
From: “Rana” sip:106@192.168.1.6;tag=176g6487588396007563566m
To: sip:108@192.168.1.6
Call-ID: 174e6978813548881006543k72800rmwp
CSeq: 11389 MESSAGE
Max-Forwards: 70
Contact: “Rana” sip:106@192.168.1.152:12804
User-Agent: MizuDroid/3.4.1
Supported: replaces
Allow: ACK,PRACK,BYE,CANCEL,INVITE,UPDATE,MESSAGE,INFO,OPTIONS,SUBSCRIBE,NOTIFY, REFER
Allow-Events: presence,refer,telephone-event,keep-alive,dialog
Accept: application/sdp,application/dtmf-relay,text/plain
Content-Type: application/im-iscomposing+xml
Content-Length: 338

<?xml version="1.0" encoding="UTF-8"?>


active
text
60

<------------->
— (15 headers 9 lines) —
Sending to 192.168.1.152:12804 (no NAT)
Receiving message!

<— Transmitting (no NAT) to 192.168.1.152:12804 —>
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/UDP 192.168.1.152:12804;branch=z9hG4bK-177p955748942511667906r;rece ived=192.168.1.152;rport=12804
From: “Rana” sip:106@192.168.1.6;tag=176g6487588396007563566m
To: sip:108@192.168.1.6;tag=as71900773
Call-ID: 174e6978813548881006543k72800rmwp
CSeq: 11389 MESSAGE
Server: FPBX-15.0.17.34(17.9.3)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘174e6978813548881006543k72800rmwp’ in 3200 0 ms (Method: MESSAGE)

<— SIP read from UDP:192.168.1.152:12804 —>
MESSAGE sip:108@192.168.1.6 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.152:12804;rport;branch=z9hG4bK-181p601874274858053789 7r
From: “Rana” sip:106@192.168.1.6;tag=180g4563056591685965159m
To: sip:108@192.168.1.6
Call-ID: 178e8489676329574589442k72801rmwp
CSeq: 19870 MESSAGE
Max-Forwards: 70
Contact: “Rana” sip:106@192.168.1.152:12804
User-Agent: MizuDroid/3.4.1
Supported: replaces
Allow: ACK,PRACK,BYE,CANCEL,INVITE,UPDATE,MESSAGE,INFO,OPTIONS,SUBSCRIBE,NOTIFY, REFER
Allow-Events: presence,refer,telephone-event,keep-alive,dialog
Accept: application/sdp,application/dtmf-relay,text/plain
Content-Type: application/im-iscomposing+xml
Content-Length: 338

<?xml version="1.0" encoding="UTF-8"?>


active
text
60

<------------->
— (15 headers 9 lines) —
Sending to 192.168.1.152:12804 (no NAT)
Receiving message!

<— Transmitting (no NAT) to 192.168.1.152:12804 —>
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/UDP 192.168.1.152:12804;branch=z9hG4bK-181p6018742748580537897r;rec eived=192.168.1.152;rport=12804
From: “Rana” sip:106@192.168.1.6;tag=180g4563056591685965159m
To: sip:108@192.168.1.6;tag=as5a96d5ec
Call-ID: 178e8489676329574589442k72801rmwp
CSeq: 19870 MESSAGE
Server: FPBX-15.0.17.34(17.9.3)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘178e8489676329574589442k72801rmwp’ in 3200 0 ms (Method: MESSAGE)

<— SIP read from UDP:192.168.1.152:12804 —>
MESSAGE sip:108@192.168.1.6 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.152:12804;rport;branch=z9hG4bK-185p495358422646354768 r
From: “Rana” sip:106@192.168.1.6;tag=184g5578641678658750034m
To: sip:108@192.168.1.6
Call-ID: 182e4632926967500615675k72802rmwp
CSeq: 13031 MESSAGE
Max-Forwards: 70
Contact: “Rana” sip:106@192.168.1.152:12804
User-Agent: MizuDroid/3.4.1
Supported: replaces
Allow: ACK,PRACK,BYE,CANCEL,INVITE,UPDATE,MESSAGE,INFO,OPTIONS,SUBSCRIBE,NOTIFY, REFER
Allow-Events: presence,refer,telephone-event,keep-alive,dialog
Accept: application/sdp,application/dtmf-relay,text/plain
X-XCMSGID: 5575
Content-Type: text/plain
Content-Length: 63

DELAYED DELIVERY [٢٠٢١.٠٦.١٩ ٢٣:٥٦:٣٥]:
Moh
NOW:
Khalid
<------------->
— (16 headers 4 lines) —
Sending to 192.168.1.152:12804 (no NAT)
Receiving message!
Looking for 108 in astsms (domain 192.168.1.6)

<— Transmitting (no NAT) to 192.168.1.152:12804 —>
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 192.168.1.152:12804;branch=z9hG4bK-185p495358422646354768r;rece ived=192.168.1.152;rport=12804
From: “Rana” sip:106@192.168.1.6;tag=184g5578641678658750034m
To: sip:108@192.168.1.6;tag=as2efd0f83
Call-ID: 182e4632926967500615675k72802rmwp
CSeq: 13031 MESSAGE
Server: FPBX-15.0.17.34(17.9.3)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘182e4632926967500615675k72802rmwp’ in 3200 0 ms (Method: MESSAGE)
Retransmitting #1 (no NAT) to 172.26.192.1:21444:
OPTIONS sip:104@172.26.192.1:21444 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK42a90785
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as3aa7f680
To: sip:104@172.26.192.1:21444
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Retransmitting #2 (no NAT) to 172.26.192.1:21444:
OPTIONS sip:104@172.26.192.1:21444 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK42a90785
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as3aa7f680
To: sip:104@172.26.192.1:21444
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Retransmitting #3 (no NAT) to 172.26.192.1:21444:
OPTIONS sip:104@172.26.192.1:21444 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK42a90785
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as3aa7f680
To: sip:104@172.26.192.1:21444
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Retransmitting #4 (no NAT) to 172.26.192.1:21444:
OPTIONS sip:104@172.26.192.1:21444 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK42a90785
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as3aa7f680
To: sip:104@172.26.192.1:21444
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Really destroying SIP dialog ‘0c2792b92cca43761089c03c63ff4db0@192.168.1.6:5060’ Method: OPTIONS

<— SIP read from UDP:192.168.1.4:60812 —>
MESSAGE sip:106@192.168.1.6:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.4:60812;rport;branch=z9hG4bKPjb59d26ad5a704583ace3a03 f0592df87
Max-Forwards: 70
From: sip:108@192.168.1.6;tag=4fa564a28ae445a182a8f3eeda71ff1f
To: sip:106@192.168.1.6
Call-ID: 424ee8187d1f4b239635750c87c839f6
CSeq: 17488 MESSAGE
User-Agent: MicroSIP/3.20.6
Content-Type: text/plain
Content-Length: 5

fffff
<------------->
— (10 headers 1 lines) —
Sending to 192.168.1.4:60812 (no NAT)
Receiving message!
Looking for 106 in astsms (domain 192.168.1.6)

<— Transmitting (no NAT) to 192.168.1.4:60812 —>
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 192.168.1.4:60812;branch=z9hG4bKPjb59d26ad5a704583ace3a03f0592d f87;received=192.168.1.4;rport=60812
From: sip:108@192.168.1.6;tag=4fa564a28ae445a182a8f3eeda71ff1f
To: sip:106@192.168.1.6;tag=as67fef93b
Call-ID: 424ee8187d1f4b239635750c87c839f6
CSeq: 17488 MESSAGE
Server: FPBX-15.0.17.34(17.9.3)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘424ee8187d1f4b239635750c87c839f6’ in 32000 ms (Method: MESSAGE)
Reliably Transmitting (no NAT) to 192.168.1.4:5060:
OPTIONS sip:100@192.168.1.4;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK4bf60c06
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as0bf611e0
To: sip:100@192.168.1.4;transport=udp
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Retransmitting #1 (no NAT) to 192.168.1.4:5060:
OPTIONS sip:100@192.168.1.4;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK4bf60c06
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as0bf611e0
To: sip:100@192.168.1.4;transport=udp
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


<— SIP read from UDP:192.168.1.4:60812 —>

<------------->
Retransmitting #2 (no NAT) to 192.168.1.4:5060:
OPTIONS sip:100@192.168.1.4;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK4bf60c06
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as0bf611e0
To: sip:100@192.168.1.4;transport=udp
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Retransmitting #3 (no NAT) to 192.168.1.4:5060:
OPTIONS sip:100@192.168.1.4;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK4bf60c06
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as0bf611e0
To: sip:100@192.168.1.4;transport=udp
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Really destroying SIP dialog ‘42d8a7662b0e4ecab71208c3124c18a2’ Method: REGISTER
Retransmitting #4 (no NAT) to 192.168.1.4:5060:
OPTIONS sip:100@192.168.1.4;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.6:5060;branch=z9hG4bK4bf60c06
Max-Forwards: 70
From: “Unknown” sip:Unknown@192.168.1.6;tag=as0bf611e0
To: sip:100@192.168.1.4;transport=udp
Contact: sip:Unknown@192.168.1.6:5060
Call-ID: 137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.17.34(17.9.3)
Date: Sat, 19 Jun 2021 21:57:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Content-Length: 0


Really destroying SIP dialog ‘137fbc6b4e09baea3e911c6b0ceea13f@192.168.1.6:5060’ Method: OPTIONS
freepbx*CLI> sip set debug off
SIP Debugging Disabled
– Unregistered SIP ‘106’
– Registered SIP ‘106’ at 192.168.1.152:12804
– Unregistered SIP ‘106’
[2021-06-19 23:59:09] NOTICE[2503]: chan_sip.c:29981 check_rtp_timeout: Disconne cting call ‘SIP/106-00000004’ for lack of RTP activity in 31 seconds
– Channel SIP/106-00000004 left ‘simple_bridge’ basic-bridge <55776fcc-675f -40ff-a7c6-cf9d96b91718>
– Channel SIP/108-00000003 left ‘simple_bridge’ basic-bridge <55776fcc-675f -40ff-a7c6-cf9d96b91718>
== Spawn extension (macro-dial-one, s, 56) exited non-zero on ‘SIP/108-0000000 3’ in macro ‘dial-one’
== Spawn extension (macro-exten-vm, s, 14) exited non-zero on ‘SIP/108-0000000 3’ in macro ‘exten-vm’
== Spawn extension (ext-local, 106, 3) exited non-zero on ‘SIP/108-00000003’
– Executing [h@ext-local:1] Macro(“SIP/108-00000003”, “hangupcall,”) in new stack
– Executing [s@macro-hangupcall:1] GotoIf(“SIP/108-00000003”, “1?theend”) i n new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf(“SIP/108-00000003”, “0?Set(CDR(re cordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:4] NoOp(“SIP/108-00000003”, "SIP/106-000000 04 montior file= ") in new stack
– Executing [s@macro-hangupcall:5] GotoIf(“SIP/108-00000003”, “1?skipagi”) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] Hangup(“SIP/108-00000003”, “”) in new st ack
== Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘SIP/108-000000 03’ in macro ‘hangupcall’
== Spawn extension (ext-local, h, 1) exited non-zero on ‘SIP/108-00000003’
== Extension Changed 108[ext-local] new state Idle for Notify User 106
== Extension Changed 108[ext-local] new state Idle for Notify User 106
[2021-06-19 23:59:15] WARNING[2503]: chan_sip.c:4142 retrans_pkt: Retransmission timeout reached on transmission 198e3927256720194978216k72806rmwp for seqno 103 (Critical Request) – See https://wiki.asterisk.org/wiki/display/AST/SIP+Retran smissions
Packet timed out after 6388ms with no response
[2021-06-19 23:59:34] WARNING[2503]: chan_sip.c:4142 retrans_pkt: Retransmission timeout reached on transmission 130e3398047734364277627k72789rmwp for seqno 107 (Critical Request) – See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 25343ms with no response


(Dave Burgess) #22

You really should be using pastebin.freepbx.org for these log dumps. They are nearly impossible to read in the messages.


(Rana hashem) #23

this sip debug from csip on labtop and muizdroid on smartphone but not messsges fron two softphone


(Rana hashem) #24

https://pastebin.freepbx.org/view/0a72f58f