You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
ip to ip.NullPointerException: null upcall object in pj::Call::onCallState , java.lang.NullPointerException: null upcall object in pj::Call::onCallTsxState and resend old msg 180 rinding
#3950
I'm running Android 8.1, using IP to IP for LAN communication. This problem seems to occur when multiple CALLs are disconnected from the network after calling/ringing. Not entirely sure how to reproduce. Appeared 2 times. What the log shows seems to be that the expired CALL timer is not destroyed, resulting in repeated attempts to retransmit. This causes "null upcall object in pj::Call::onCallTsxState" and "null upcall object in pj::Call::onCallState". There is currently no more detailed log
java.lang.NullPointerException: null upcall object in pj::Call::onCallState
java.lang.NullPointerException: null upcall object in pj::Call::onCallTsxState
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: --end msg--
Steps to reproduce
I'm running Android 8.1, using IP to IP for LAN communication. This problem seems to occur when multiple CALLs are disconnected from the network after calling/ringing. Not entirely sure how to reproduce. Appeared 2 times. What the log shows seems to be that the expired CALL timer is not destroyed, resulting in repeated attempts to retransmit. This causes "null upcall object in pj::Call::onCallTsxState" and "null upcall object in pj::Call::onCallState". There is currently no more detailed log
PJSIP version
2.12
Context
Android OS 8.1
Log, call stack, etc
05-09 15:20:13.010 3883 3972 E AndroidRuntime: java.lang.NullPointerException: null upcall object in pj::Call::onCallTsxState
05-09 15:20:13.013 3883 3972 E AndroidRuntime: java.lang.NullPointerException: null upcall object in pj::Call::onCallState
05-09 16:07:55.060 3883 3972 D pjsip-pjsua_0: 16:07:55.058 tsx0xc0cfc864 Retransmit timer event
05-09 16:07:55.062 3883 3972 D pjsip-pjsua_0: 16:07:55.061 tsx0xc0cfc864 .Retransmiting Response msg 180/INVITE/cseq=7220 (tdta0xc41c6064), count=80, restart?=1
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: 16:07:55.063 pjsua_core.c .TX 545 bytes Response msg 180/INVITE/cseq=7220 (tdta0xc41c6064) to UDP 192.168.1.105:5060:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjCsMdhdUVEEZzcZWtPD8Q7qLo4cgnwk3r
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Call-ID: S.yf6J.qiGUy3xpIPG-mQMDeNUtbrxxf
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=TQjK-HyH2C67MSu5mmkx61vnFbgEMLS2
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=07a8aa0c-1689-4121-beca-5b4509559138
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: CSeq: 7220 INVITE
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.079 3883 3972 D pjsip-pjsua_0: 16:07:55.076 tlsc0xc1035414 Sending 4 byte(s) keep-alive to open-sips.gvs-icloud.com:5061
05-09 16:07:55.089 3883 3972 D pjsip-pjsua_0: 16:07:55.087 tsx0xc1da7864 Retransmit timer event
05-09 16:07:55.091 3883 3972 D pjsip-pjsua_0: 16:07:55.090 tsx0xc1da7864 .Retransmiting Response msg 180/INVITE/cseq=15161 (tdta0xc1dab064), count=82, restart?=1
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: 16:07:55.092 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=15161 (tdta0xc1dab064) to UDP 192.168.1.105:5060:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjE9NuBy1TwUJVAtftQ06TRV3IjYIFPE84
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Call-ID: K1X4ZMmHAI.ra3EjP2kR-uhcsU6vJ-oT
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=Qd.we67wAtzidA6h01BCCJdiJV50mwdh
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=6b3241a5-5875-4830-9342-f0e73756ab43
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: CSeq: 15161 INVITE
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.106 3883 3972 D pjsip-pjsua_0: 16:07:55.104 tsx0xc10a0864 Retransmit timer event
05-09 16:07:55.108 3883 3972 D pjsip-pjsua_0: 16:07:55.107 tsx0xc10a0864 .Retransmiting Response msg 180/INVITE/cseq=679 (tdta0xc10b1064), count=77, restart?=1
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: 16:07:55.108 pjsua_core.c .TX 544 bytes Response msg 180/INVITE/cseq=679 (tdta0xc10b1064) to UDP 192.168.1.105:5060:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjWqOObqaXPE-r0BAa3fcjUlNSp2AE3jzh
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Call-ID: 82SGKjymwlqJY8Sj0a0NUm5RkQ6ibBNj
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=bQmB1e.pkib4aWc1lHtKwVQp2Vp7M8XL
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=00a628fc-065f-4785-983b-c3a88bb38036
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: CSeq: 679 INVITE
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.119 3883 3972 D pjsip-pjsua_0: 16:07:55.117 tsx0xc0d0f864 Retransmit timer event
05-09 16:07:55.124 3883 3972 D pjsip-pjsua_0: 16:07:55.120 tsx0xc0d0f864 .Retransmiting Response msg 180/INVITE/cseq=26050 (tdta0xc1124064), count=74, restart?=1
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: 16:07:55.125 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=26050 (tdta0xc1124064) to UDP 192.168.1.105:5060:
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjV7up2JcD9E.tIWj50zr9OwnNpGdFVona
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: Call-ID: vmLtgqsbiYkZVieGXAgf8gLr2Z9DuWUW
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=GfzalxJUoyqZV4x8osehyWOXnjnwfmFm
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=4d993e27-331c-4ef3-8292-4bfdac19abc6
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: CSeq: 26050 INVITE
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.126 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.139 3883 3972 D pjsip-pjsua_0: 16:07:55.137 tsx0xc1da7064 Retransmit timer event
05-09 16:07:55.141 3883 3972 D pjsip-pjsua_0: 16:07:55.140 tsx0xc1da7064 .Retransmiting Response msg 180/INVITE/cseq=30412 (tdta0xc0125064), count=82, restart?=1
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: 16:07:55.141 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=30412 (tdta0xc0125064) to UDP 192.168.1.105:5060:
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPj.fufsZLRxAI1i6byfP6tUtOvkRMqBKdG
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: Call-ID: EcOYuklP7kKWKf-2QRQJdFuWeLeORjCN
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=rqKmQywreazelbtNLDqUzjZ6VYMzTbmy
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=3d29c01a-04de-45b6-87a3-c6475ec8d946
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: CSeq: 30412 INVITE
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.143 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.150 3883 3972 D pjsip-pjsua_0: 16:07:55.148 tsx0xc0ebc864 Retransmit timer event
05-09 16:07:55.151 3883 3972 D pjsip-pjsua_0: 16:07:55.150 tsx0xc0ebc864 .Retransmiting Response msg 180/INVITE/cseq=23522 (tdta0xc0c7f064), count=81, restart?=1
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: 16:07:55.152 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=23522 (tdta0xc0c7f064) to UDP 192.168.1.105:5060:
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPj6B4D5qhyx.rHQLEqlP5cjfPEcNu6ps5F
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: Call-ID: .OMi0scLXCdIs4BClqRMotG7GXmzMwl4
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=2efpyz-MbiubDBnVtBr6YgToI3Z.qz3F
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=9178bef9-4599-4614-bb60-542b3f3207d1
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: CSeq: 23522 INVITE
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.154 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.165 3883 3972 D pjsip-pjsua_0: 16:07:55.163 tsx0xc0d7e864 Retransmit timer event
05-09 16:07:55.167 3883 3972 D pjsip-pjsua_0: 16:07:55.166 tsx0xc0d7e864 .Retransmiting Response msg 180/INVITE/cseq=7762 (tdta0xc10d0064), count=80, restart?=1
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: 16:07:55.168 pjsua_core.c .TX 545 bytes Response msg 180/INVITE/cseq=7762 (tdta0xc10d0064) to UDP 192.168.1.105:5060:
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjNXbHI9Ct7cziGjznLTWVpuw6LcyXUf6t
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: Call-ID: 8G0WKnApuRye-miT-AFuabDuFUQaAug-
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=FmsPwB9540iZcx1wOJ-yTVV8uCxjGIfY
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=71a18fc9-52f6-4ba2-8171-29d2a071b849
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: CSeq: 7762 INVITE
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.169 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.176 3883 3972 D pjsip-pjsua_0: 16:07:55.174 tsx0xc0d7e064 Retransmit timer event
05-09 16:07:55.178 3883 3972 D pjsip-pjsua_0: 16:07:55.177 tsx0xc0d7e064 .Retransmiting Response msg 180/INVITE/cseq=8655 (tdta0xc0dfe064), count=84, restart?=1
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: 16:07:55.178 pjsua_core.c .TX 545 bytes Response msg 180/INVITE/cseq=8655 (tdta0xc0dfe064) to UDP 192.168.1.105:5060:
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjoU2dooBGFrhPN1eNGNisViDB2Y1z2zbq
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: Call-ID: aiBo92FsAyqrbfwTrKH4-BGbhBO31ezy
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=MdsJRulFfwjDC6WGeBTFixzaKNs-xrBc
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=453a63da-7ff7-498f-bc34-8841b5c427ed
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: CSeq: 8655 INVITE
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.180 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.182 3883 3972 D pjsip-pjsua_0: 16:07:55.181 tsx0xc017f864 Retransmit timer event
05-09 16:07:55.183 3883 3972 D pjsip-pjsua_0: 16:07:55.182 tsx0xc017f864 .Retransmiting Response msg 180/INVITE/cseq=29690 (tdta0xc1d6e064), count=75, restart?=1
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: 16:07:55.184 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=29690 (tdta0xc1d6e064) to UDP 192.168.1.105:5060:
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjef3Mw8bUuK2lMPI6Q.7K-I3ECqdXgZs0
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: Call-ID: 7f0COaJwbSKrQ6R1rXm64htMZZxR7SAS
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=xWDeKTArb4emfgLpT.Ekywm-OXySYsKh
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=a82a25a1-f03b-4883-bb6a-77560d97d94c
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: CSeq: 29690 INVITE
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.186 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.199 3883 3972 D pjsip-pjsua_0: 16:07:55.197 tsx0xc01ce064 Retransmit timer event
05-09 16:07:55.204 3883 3972 D pjsip-pjsua_0: 16:07:55.203 tsx0xc01ce064 .Retransmiting Response msg 180/INVITE/cseq=1006 (tdta0xc10d3064), count=68, restart?=1
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: 16:07:55.206 pjsua_core.c .TX 545 bytes Response msg 180/INVITE/cseq=1006 (tdta0xc10d3064) to UDP 192.168.1.105:5060:
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPj5ob98Xjjryk99ozetpTpsFqNredNRxtZ
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: Call-ID: ixnRdZ3hLli2aY73vRz9j7Hdz-QwUeEy
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: From: <sip:405579132320223232@192.168.1.105>;tag=RAVXAk-7qr6oh2h5wShpP4B4c4GT6HoI
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: To: <sip:457007454442622976@192.168.1.101>;tag=7881380d-8b50-40ad-b340-7c7744261100
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: CSeq: 1006 INVITE
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: Contact: <sip:457007454442622976@192.168.1.101:5060>
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.209 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.294 3883 3972 D pjsip-pjsua_0: 16:07:55.293 tsx0xc0ca3864 Timeout timer event
05-09 16:07:55.296 3883 3972 D pjsip-pjsua_0: 16:07:55.295 tsx0xc0ca3864 .State changed from Calling to Terminated, event=TIMER
05-09 16:07:55.297 3883 3972 D pjsip-pjsua_0: 16:07:55.297 pjsua_acc.c ...2contact_rewritten:0,rewrite_method:6,code:408
05-09 16:07:55.299 3883 3972 D pjsip-pjsua_0: 16:07:55.298 pjsua_acc.c ...SIP registration failed, status=408 (Request Timeout)
05-09 16:07:55.300 3883 3972 D pjsip-pjsua_0: 16:07:55.299 pjsua_acc.c ...Scheduling re-registration retry foracc 1in 18 seconds..
05-09 16:07:55.302 3883 3972 D PjsipBusiness: loginCloudAccount:1737342028959842304-----open-sips.gvs-icloud.com-----408
05-09 16:07:55.313 3883 3972 D pjsip-pjsua_0: 16:07:55.311 tsx0xc0ca3864 Timeout timer event
05-09 16:07:55.314 3883 3972 D pjsip-pjsua_0: 16:07:55.313 tsx0xc0ca3864 .State changed from Terminated to Destroyed, event=TIMER
05-09 16:07:55.316 3883 3972 D pjsip-pjsua_0: 16:07:55.315 tdta0xc0aea064 ..Destroying txdata Request msg REGISTER/cseq=20030 (tdta0xc0aea064)
05-09 16:07:55.317 3883 3972 D pjsip-pjsua_0: 16:07:55.316 tsx0xc0ca3864 Transaction destroyed!
05-09 16:08:05.001 3883 3972 D pjsip-pjsua_0: 16:08:04.999 tlsc0xc1035414 TLS connection closed
05-09 16:08:05.011 3883 3972 D pjsip-pjsua_0: 16:08:05.007 pjsua_acc.c Disconnected notification for transport tlsc0xc1035414
05-09 16:08:05.014 3883 3972 D pjsip-pjsua_0: 16:08:05.013 sip_transport. .Transport tlsc0xc1035414 shutting down, force=0
05-09 16:08:05.020 3883 3972 D pjsip-pjsua_0: 16:08:05.018 tlsc0xc1035414 TLS transport destroyed with reason 120110: Connection timed out
05-09 16:08:13.321 3883 3972 D pjsip-pjsua_0: 16:08:13.320 addr_resolv_so DNS resolver pj_getaddrinfo
05-09 16:08:13.322 3883 3972 D pjsip-pjsua_0: 16:08:13.321 addr_resolv_so DNS resolver pj_getaddrinfo1
05-09 16:08:13.335 3883 3972 D pjsip-pjsua_0: 16:08:13.334 addr_resolv_so DNS resolver pj_getaddrinfo2
05-09 16:08:13.336 3883 3972 D pjsip-pjsua_0: 16:08:13.335 addr_resolv_so DNS resolver pj_getaddrinfo3
05-09 16:08:13.338 3883 3972 D pjsip-pjsua_0: 16:08:13.337 tlsc0xc1034014 TLS client transport created
05-09 16:08:13.341 3883 3972 D pjsip-pjsua_0: 16:08:13.340 tlsc0xc1034014 TLS transport 192.168.1.101:49159 is connecting to open-sips.gvs-icloud.com:5061...
05-09 16:08:13.343 3883 3972 D pjsip-pjsua_0: 16:08:13.342 pjsua_acc.c 2acc->contact: <sip:1737342028959842304@192.168.1.101:49159;transport=TLS;ob>
05-09 16:08:13.344 3883 3972 D pjsip-pjsua_0: 16:08:13.344 pjsua_acc.c Contact for acc 1 updated: <sip:1737342028959842304@192.168.1.101:49159;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000e922f243>"
05-09 16:08:13.345 3883 3972 D pjsip-pjsua_0: 16:08:13.345 pjsua_acc.c Acc 1: setting registration..
05-09 16:08:13.349 3883 3972 D pjsip-pjsua_0: 16:08:13.348 endpoint .Request msg REGISTER/cseq=43928 (tdta0xc1f7f064) created.
05-09 16:08:13.352 3883 3972 D pjsip-pjsua_0: 16:08:13.351 addr_resolv_so .DNS resolver pj_getaddrinfo
05-09 16:08:13.354 3883 3972 D pjsip-pjsua_0: 16:08:13.353 addr_resolv_so .DNS resolver pj_getaddrinfo1
05-09 16:08:13.365 3883 3972 D pjsip-pjsua_0: 16:08:13.363 addr_resolv_so .DNS resolver pj_getaddrinfo2
05-09 16:08:13.370 3883 3972 D pjsip-pjsua_0: 16:08:13.366 addr_resolv_so .DNS resolver pj_getaddrinfo3
05-09 16:08:13.373 3883 3972 D pjsip-pjsua_0: 16:08:13.372 tsx0xcbd5f064 ..Transaction created for Request msg REGISTER/cseq=43929 (tdta0xc1f7f064)
05-09 16:08:13.374 3883 3972 D pjsip-pjsua_0: 16:08:13.374 tsx0xcbd5f064 .Sending Request msg REGISTER/cseq=43929 (tdta0xc1f7f064) in state Null
05-09 16:08:13.376 3883 3972 D pjsip-pjsua_0: 16:08:13.375 sip_resolve.c ..DNS resolver not available, target 'open-sips.gvs-icloud.com:5061' type=TLS will be resolved with getaddrinfo()
05-09 16:08:13.377 3883 3972 D pjsip-pjsua_0: 16:08:13.376 addr_resolv_so ..DNS resolver pj_getaddrinfo
05-09 16:08:13.378 3883 3972 D pjsip-pjsua_0: 16:08:13.377 addr_resolv_so ..DNS resolver pj_getaddrinfo1
05-09 16:08:13.381 3883 3972 D pjsip-pjsua_0: 16:08:13.380 addr_resolv_so ..DNS resolver pj_getaddrinfo2
05-09 16:08:13.383 3883 3972 D pjsip-pjsua_0: 16:08:13.382 addr_resolv_so ..DNS resolver pj_getaddrinfo3
05-09 16:08:13.385 3883 3972 D pjsip-pjsua_0: 16:08:13.384 sip_resolve.c ..Target 'open-sips.gvs-icloud.com:5061' type=TLS resolved to '47.112.115.103:5061' type=TLS (TLS transport)
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: 16:08:13.385 pjsua_core.c ..TX 804 bytes Request msg REGISTER/cseq=43929 (tdta0xc1f7f064) to TLS 47.112.115.103:5061:
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: REGISTER sip:open-sips.gvs-icloud.com:5061 SIP/2.0
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/TLS 192.168.1.101:49159;rport;branch=z9hG4bKPjc8343b47-c40f-4319-abe7-94db97f4c739;alias
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Route: <sip:open-sips.gvs-icloud.com:5061;transport=tls;lr>
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Max-Forwards: 70
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: From: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=d630a749-7127-46f1-af2c-c5016c5ede59
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: To: <sip:1737342028959842304@open-sips.gvs-icloud.com>
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Call-ID: 9d44aa7c-d76a-4672-aa29-4e403014f5d9
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: CSeq: 43929 REGISTER
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: User-Agent: Pjsua2 Android 2.12.1-dev
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Supported: outbound, path
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Contact: <sip:1737342028959842304@192.168.1.101:49159;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000e922f243>"
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Expires: 600
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.386 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:08:13.387 3883 3972 D pjsip-pjsua_0: 16:08:13.386 tsx0xcbd5f064 ..State changed from Null to Calling, event=TX_MSG
05-09 16:08:13.388 3883 3972 D pjsip-pjsua_0: 16:08:13.388 pjsua_acc.c .Acc 1: Registration sent
05-09 16:08:13.467 3883 3972 D pjsip-pjsua_0: 16:08:13.466 tlsc0xc1034014 TLS transport 192.168.1.101:49159 is connected to open-sips.gvs-icloud.com:5061
05-09 16:08:13.501 3883 3972 D pjsip-pjsua_0: 16:08:13.499 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=43929 (rdata0xc10341cc)
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: 16:08:13.502 pjsua_core.c .RX 611 bytes Response msg 401/REGISTER/cseq=43929 (rdata0xc10341cc) from TLS 47.112.115.103:5061:
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: SIP/2.0 401 Unauthorized
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/TLS 192.168.1.101:49159;received=14.19.179.110;rport=49159;branch=z9hG4bKPjc8343b47-c40f-4319-abe7-94db97f4c739;alias
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: From: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=d630a749-7127-46f1-af2c-c5016c5ede59
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: To: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=70ab.3be40540eecccc4a43089b901f971570
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: Call-ID: 9d44aa7c-d76a-4672-aa29-4e403014f5d9
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: CSeq: 43929 REGISTER
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: WWW-Authenticate: Digest realm="open-sips.gvs-icloud.com", nonce="7/5SzcwD30nXCLMFLQ5dabVZC9OiznLPgzLkG0mbjNAA", qop="auth"
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: Server: OpenSIPS (3.2.3 (x86_64/linux))
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.503 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:08:13.504 3883 3972 D pjsip-pjsua_0: 16:08:13.503 tsx0xcbd5f064 .Incoming Response msg 401/REGISTER/cseq=43929 (rdata0xc10341cc) in state Calling
05-09 16:08:13.505 3883 3972 D pjsip-pjsua_0: 16:08:13.504 tsx0xcbd5f064 ..State changed from Calling to Completed, event=RX_MSG
05-09 16:08:13.506 3883 3972 D pjsip-pjsua_0: 16:08:13.505 pjsua_acc.c ....1contact_rewritten:0,rewrite_method:6,code:401
05-09 16:08:13.507 3883 3972 D pjsip-pjsua_0: 16:08:13.506 pjsua_acc.c ....acc->contact:<sip:1737342028959842304@192.168.1.101:49159;transport=TLS;ob>
05-09 16:08:13.508 3883 3972 D pjsip-pjsua_0: 16:08:13.507 pjsua_acc.c ....IP address change detected for account 1 (192.168.1.101:49159 --> 14.19.179.110:49159). Updating registration (using method 4)
05-09 16:08:13.509 3883 3972 D pjsip-pjsua_0: 16:08:13.508 pjsua_acc.c ....1acc->contact: <sip:1737342028959842304@14.19.179.110:49159;transport=TLS;ob>
05-09 16:08:13.511 3883 3972 D pjsip-pjsua_0: 16:08:13.510 pjsua_acc.c ....Contact for acc 1 updated: <sip:1737342028959842304@14.19.179.110:49159;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000e922f243>"
05-09 16:08:13.514 3883 3972 D pjsip-pjsua_0: 16:08:13.513 sip_auth_clien ...Digest algorithm is ""
05-09 16:08:13.523 3883 3972 D pjsip-pjsua_0: 16:08:13.521 tsx0xc0156864 ....Transaction created for Request msg REGISTER/cseq=43930 (tdta0xc1f7f064)
05-09 16:08:13.529 3883 3972 D pjsip-pjsua_0: 16:08:13.525 tsx0xc0156864 ...Sending Request msg REGISTER/cseq=43930 (tdta0xc1f7f064) in state Null
05-09 16:08:13.531 3883 3972 D pjsip-pjsua_0: 16:08:13.530 endpoint ....Request msg REGISTER/cseq=43930 (tdta0xc1f7f064): skipping target resolution because address is already set
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: 16:08:13.534 pjsua_core.c ....TX 1098 bytes Request msg REGISTER/cseq=43930 (tdta0xc1f7f064) to TLS 47.112.115.103:5061:
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: REGISTER sip:open-sips.gvs-icloud.com:5061 SIP/2.0
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/TLS 14.19.179.110:49159;rport;branch=z9hG4bKPj4f144793-7910-4e22-a173-a81cb48e51ff;alias
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Route: <sip:open-sips.gvs-icloud.com:5061;transport=tls;lr>
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Max-Forwards: 70
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: From: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=d630a749-7127-46f1-af2c-c5016c5ede59
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: To: <sip:1737342028959842304@open-sips.gvs-icloud.com>
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Call-ID: 9d44aa7c-d76a-4672-aa29-4e403014f5d9
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: CSeq: 43930 REGISTER
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: User-Agent: Pjsua2 Android 2.12.1-dev
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Supported: outbound, path
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Contact: <sip:1737342028959842304@14.19.179.110:49159;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000e922f243>"
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Expires: 600
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Authorization: Digest username="1737342028959842304", realm="open-sips.gvs-icloud.com", nonce="7/5SzcwD30nXCLMFLQ5dabVZC9OiznLPgzLkG0mbjNAA", uri="sip:open-sips.gvs-icloud.com:5061", response="b2856052e744cd42003bb2fe71f3b55f", cnonce="8fff2aee4a084081a007b3b75791d505", qop=auth, nc=00000001
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.536 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:08:13.538 3883 3972 D pjsip-pjsua_0: 16:08:13.537 tsx0xc0156864 ....State changed from Null to Calling, event=TX_MSG
05-09 16:08:13.541 3883 3972 D pjsip-pjsua_0: 16:08:13.539 tsx0xcbd5f064 Timeout timer event
05-09 16:08:13.543 3883 3972 D pjsip-pjsua_0: 16:08:13.541 tsx0xcbd5f064 .State changed from Completed to Terminated, event=TIMER
05-09 16:08:13.549 3883 3972 D pjsip-pjsua_0: 16:08:13.547 tsx0xcbd5f064 Timeout timer event
05-09 16:08:13.550 3883 3972 D pjsip-pjsua_0: 16:08:13.549 tsx0xcbd5f064 .State changed from Terminated to Destroyed, event=TIMER
05-09 16:08:13.551 3883 3972 D pjsip-pjsua_0: 16:08:13.551 tsx0xcbd5f064 Transaction destroyed!
05-09 16:08:13.572 3883 3972 D pjsip-pjsua_0: 16:08:13.571 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=43930 (rdata0xc10341cc)
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: 16:08:13.573 pjsua_core.c .RX 610 bytes Response msg 200/REGISTER/cseq=43930 (rdata0xc10341cc) from TLS 47.112.115.103:5061:
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: SIP/2.0 200 OK
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/TLS 14.19.179.110:49159;received=14.19.179.110;rport=49159;branch=z9hG4bKPj4f144793-7910-4e22-a173-a81cb48e51ff;alias
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: From: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=d630a749-7127-46f1-af2c-c5016c5ede59
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: To: <sip:1737342028959842304@open-sips.gvs-icloud.com>;tag=70ab.d82bfc473dfa0beff6934b2053ea1df8
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: Call-ID: 9d44aa7c-d76a-4672-aa29-4e403014f5d9
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: CSeq: 43930 REGISTER
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: Contact: <sip:1737342028959842304@14.19.179.110:49159;transport=TLS;ob>;expires=600;received="sip:14.19.179.110:49159;transport=tls"
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: Server: OpenSIPS (3.2.3 (x86_64/linux))
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0:
05-09 16:08:13.574 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:08:13.575 3883 3972 D pjsip-pjsua_0: 16:08:13.574 tsx0xc0156864 .Incoming Response msg 200/REGISTER/cseq=43930 (rdata0xc10341cc) in state Calling
05-09 16:08:13.577 3883 3972 D pjsip-pjsua_0: 16:08:13.576 tsx0xc0156864 ..State changed from Calling to Completed, event=RX_MSG
05-09 16:08:13.578 3883 3972 D pjsip-pjsua_0: 16:08:13.577 pjsua_acc.c ....2contact_rewritten:0,rewrite_method:6,code:200
05-09 16:08:13.579 3883 3972 D pjsip-pjsua_0: 16:08:13.578 pjsua_acc.c ....SIP outbound status for acc 1 is not active
05-09 16:08:13.580 3883 3972 D pjsip-pjsua_0: 16:08:13.579 pjsua_acc.c ....acc->contact:<sip:1737342028959842304@14.19.179.110:49159;transport=TLS;ob>
05-09 16:08:13.581 3883 3972 D pjsip-pjsua_0: 16:08:13.580 pjsua_acc.c ....sip:1737342028959842304@open-sips.gvs-icloud.com: registration success, status=200 (OK), will re-register in 600 seconds
05-09 16:08:13.583 3883 3972 D PjsipBusiness: loginCloudAccount:1737342028959842304-----open-sips.gvs-icloud.com-----200
05-09 16:08:13.585 3883 3972 D pjsip-pjsua_0: 16:08:13.584 tsx0xc0156864 Timeout timer event
05-09 16:08:13.587 3883 3972 D pjsip-pjsua_0: 16:08:13.586 tsx0xc0156864 .State changed from Completed to Terminated, event=TIMER
05-09 16:08:13.592 3883 3972 D pjsip-pjsua_0: 16:08:13.590 tsx0xc0156864 Timeout timer event
05-09 16:08:13.593 3883 3972 D pjsip-pjsua_0: 16:08:13.592 tsx0xc0156864 .State changed from Terminated to Destroyed, event=TIMER
05-09 16:08:13.598 3883 3972 D pjsip-pjsua_0: 16:08:13.594 tdta0xc1f7f064 ..Destroying txdata Request msg REGISTER/cseq=43930 (tdta0xc1f7f064)
05-09 16:08:13.600 3883 3972 D pjsip-pjsua_0: 16:08:13.598 tsx0xc0156864 Transaction destroyed!
The text was updated successfully, but these errors were encountered:
This seems to be a pretty standard scenario: Remote cancelled the call during early state.
When testing it here using 100rel, it seems to work fine. The 180 retransmission will cease upon the call cancellation.
So there might be some unexpected situation here that caused the retransmission to continue (Btw, the timing is also a bit curious here with the exception happening at 15:20 while the rest of the log is at 16:07.) But unfortunately, without a more detailed log (that should at least include the INVITE message and the CANCEL), or steps to reproduce, there's not much we can do here.
This seems to be a pretty standard scenario: Remote cancelled the call during early state. When testing it here using 100rel, it seems to work fine. The 180 retransmission will cease upon the call cancellation.
So there might be some unexpected situation here that caused the retransmission to continue (Btw, the timing is also a bit curious here with the exception happening at 15:20 while the rest of the log is at 16:07.) But unfortunately, without a more detailed log (that should at least include the INVITE message and the CANCEL), or steps to reproduce, there's not much we can do here.
Yes, both A and B. Device B crashed during the call, causing device A to have problems as described in the log. Regarding exceptions, the exception log at 15 o'clock is not stored. Starting from the 180 retransmission, the null exception begins to exist. I just found a more detailed log. Observing from the latest logs obtained does not seem to have anything to do with this. About this exception. Let me ask another question
Describe the bug
I'm running Android 8.1, using IP to IP for LAN communication. This problem seems to occur when multiple CALLs are disconnected from the network after calling/ringing. Not entirely sure how to reproduce. Appeared 2 times. What the log shows seems to be that the expired CALL timer is not destroyed, resulting in repeated attempts to retransmit. This causes "null upcall object in pj::Call::onCallTsxState" and "null upcall object in pj::Call::onCallState". There is currently no more detailed log
java.lang.NullPointerException: null upcall object in pj::Call::onCallState
java.lang.NullPointerException: null upcall object in pj::Call::onCallTsxState
05-09 16:07:55.060 3883 3972 D pjsip-pjsua_0: 16:07:55.058 tsx0xc0cfc864 Retransmit timer event
05-09 16:07:55.062 3883 3972 D pjsip-pjsua_0: 16:07:55.061 tsx0xc0cfc864 .Retransmiting Response msg 180/INVITE/cseq=7220 (tdta0xc41c6064), count=80, restart?=1
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: 16:07:55.063 pjsua_core.c .TX 545 bytes Response msg 180/INVITE/cseq=7220 (tdta0xc41c6064) to UDP 192.168.1.105:5060:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjCsMdhdUVEEZzcZWtPD8Q7qLo4cgnwk3r
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Call-ID: S.yf6J.qiGUy3xpIPG-mQMDeNUtbrxxf
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: From: sip:405579132320223232@192.168.1.105;tag=TQjK-HyH2C67MSu5mmkx61vnFbgEMLS2
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: To: sip:457007454442622976@192.168.1.101;tag=07a8aa0c-1689-4121-beca-5b4509559138
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: CSeq: 7220 INVITE
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Contact: sip:457007454442622976@192.168.1.101:5060
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.064 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.079 3883 3972 D pjsip-pjsua_0: 16:07:55.076 tlsc0xc1035414 Sending 4 byte(s) keep-alive to open-sips.gvs-icloud.com:5061
05-09 16:07:55.089 3883 3972 D pjsip-pjsua_0: 16:07:55.087 tsx0xc1da7864 Retransmit timer event
05-09 16:07:55.091 3883 3972 D pjsip-pjsua_0: 16:07:55.090 tsx0xc1da7864 .Retransmiting Response msg 180/INVITE/cseq=15161 (tdta0xc1dab064), count=82, restart?=1
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: 16:07:55.092 pjsua_core.c .TX 546 bytes Response msg 180/INVITE/cseq=15161 (tdta0xc1dab064) to UDP 192.168.1.105:5060:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjE9NuBy1TwUJVAtftQ06TRV3IjYIFPE84
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Call-ID: K1X4ZMmHAI.ra3EjP2kR-uhcsU6vJ-oT
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: From: sip:405579132320223232@192.168.1.105;tag=Qd.we67wAtzidA6h01BCCJdiJV50mwdh
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: To: sip:457007454442622976@192.168.1.101;tag=6b3241a5-5875-4830-9342-f0e73756ab43
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: CSeq: 15161 INVITE
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Contact: sip:457007454442622976@192.168.1.101:5060
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.093 3883 3972 D pjsip-pjsua_0: --end msg--
05-09 16:07:55.106 3883 3972 D pjsip-pjsua_0: 16:07:55.104 tsx0xc10a0864 Retransmit timer event
05-09 16:07:55.108 3883 3972 D pjsip-pjsua_0: 16:07:55.107 tsx0xc10a0864 .Retransmiting Response msg 180/INVITE/cseq=679 (tdta0xc10b1064), count=77, restart?=1
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: 16:07:55.108 pjsua_core.c .TX 544 bytes Response msg 180/INVITE/cseq=679 (tdta0xc10b1064) to UDP 192.168.1.105:5060:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: SIP/2.0 180 Ringing
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Via: SIP/2.0/UDP 192.168.1.105:5060;rport=5060;received=192.168.1.105;branch=z9hG4bKPjWqOObqaXPE-r0BAa3fcjUlNSp2AE3jzh
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Call-ID: 82SGKjymwlqJY8Sj0a0NUm5RkQ6ibBNj
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: From: sip:405579132320223232@192.168.1.105;tag=bQmB1e.pkib4aWc1lHtKwVQp2Vp7M8XL
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: To: sip:457007454442622976@192.168.1.101;tag=00a628fc-065f-4785-983b-c3a88bb38036
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: CSeq: 679 INVITE
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Contact: sip:457007454442622976@192.168.1.101:5060
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: Content-Length: 0
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0:
05-09 16:07:55.110 3883 3972 D pjsip-pjsua_0: --end msg--
Steps to reproduce
I'm running Android 8.1, using IP to IP for LAN communication. This problem seems to occur when multiple CALLs are disconnected from the network after calling/ringing. Not entirely sure how to reproduce. Appeared 2 times. What the log shows seems to be that the expired CALL timer is not destroyed, resulting in repeated attempts to retransmit. This causes "null upcall object in pj::Call::onCallTsxState" and "null upcall object in pj::Call::onCallState". There is currently no more detailed log
PJSIP version
2.12
Context
Android OS 8.1
Log, call stack, etc
The text was updated successfully, but these errors were encountered: