Corrupt SIP Via: and Contact: headers after returning from sleep
Issue generated from Tuleap's migration script. Originally submitted by: szotsaki (szotsaki)
When I wake my PC up Ring tries to re-REGISTER. Interestingly, the Via: header will be corrupted and Contact: header shows a (possibly random?) local address. I tried to turn off and turn on the account again, but it had no use. When I restarted dring it suddenly started to work.
Corrupted Via: header:
Via: SIP/2.0/UDP \\000\\307\\0004\~\\177\\000\\000\\000\\000\\000\\000:58908;rport;branch=z9hG4bKPjzb7WCMvLildVXNwzvH37iofO2lqZgSwO
Contact: header shows local address (btw. it's not even my local address):
Contact: <sip:username@192.168.0.11:58908>
Correct Via: header after restart (xx.xx. was deleted by me):
Via: SIP/2.0/UDP 178.48.xx.xx:61455;rport;branch=z9hG4bKPjt7VqLj-uhYVzbr5hRzPwOe8nRADYXiRb
Correct Contact: header after restart:
Contact: <sip:username@178.48.xx.xx:61455>
Debug output while trying to register unsuccessfully:
[1465881964.596| 3999|sip\_utils.cpp:87 ] Adding route my.voip.provider.com 07:26:04.596 endpoint Request msg REGISTER/cseq=24517 (tdta0x142dd80) created. 07:26:04.596 tsx0x131c328 .Transaction created for Request msg REGISTER/cseq=24518 (tdta0x142dd80) 07:26:04.596 tsx0x131c328 Sending Request msg REGISTER/cseq=24518 (tdta0x142dd80) in state Null 07:26:04.596 endpoint .Request msg REGISTER/cseq=24518 (tdta0x142dd80): skipping target resolution because address is already set 07:26:04.596 tsx0x131c328 .State changed from Null to Calling, event=TX\_MSG 07:26:05.096 tsx0x131c328 Retransmit timer event 07:26:05.096 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=0, restart?=1 07:26:06.102 tsx0x131c328 Retransmit timer event 07:26:06.102 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=1, restart?=1 07:26:08.112 tsx0x131c328 Retransmit timer event 07:26:08.112 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=2, restart?=1 07:26:12.115 tsx0x131c328 Retransmit timer event 07:26:12.115 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=3, restart?=1 07:26:16.123 tsx0x131c328 Retransmit timer event 07:26:16.123 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=4, restart?=1 07:26:20.125 tsx0x131c328 Retransmit timer event 07:26:20.125 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=5, restart?=1 07:26:24.134 tsx0x131c328 Retransmit timer event 07:26:24.134 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=6, restart?=1 07:26:28.140 tsx0x131c328 Retransmit timer event 07:26:28.140 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=7, restart?=1 07:26:32.148 tsx0x131c328 Retransmit timer event 07:26:32.148 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=8, restart?=1 07:26:36.155 tsx0x131c328 Retransmit timer event 07:26:36.156 tsx0x131c328 .Retransmiting Request msg REGISTER/cseq=24518 (tdta0x142dd80), count=9, restart?=1 07:26:36.603 tsx0x131c328 Timeout timer event 07:26:36.603 tsx0x131c328 .State changed from Calling to Terminated, event=TIMER [1465881996.603| 3999|sipaccount.cpp:1044 ] SIP registration failed, status=408 (Request Timeout) [1465881996.603| 3999|sipaccount.cpp:2036 ] Scheduling re-registration retry in 306 seconds.. 07:26:36.603 tsx0x131c328 Timeout timer event 07:26:36.603 tsx0x131c328 .State changed from Terminated to Destroyed, event=TIMER 07:26:36.603 tdta0x142dd80 ..Destroying txdata Request msg REGISTER/cseq=24518 (tdta0x142dd80) 07:26:36.603 tsx0x131c328 Transaction destroyed!
Debug output when turning off the account:
[1465882511.064| 3999|manager.cpp:2399 ] Set account details for a67b376b942ef87c [1465882511.064| 3999|sipaccount.cpp:878 ] doUnregister VoipLinkException occurred: Registration structure is NULL [1465882511.064| 3999|sipaccount.cpp:287 ] Removing transport from account [1465882511.064| 3999|siptransport.cpp:95 ] \~SipTransport@0x126c9c8 {tr=0x13012b8 {rc=1}} [1465882511.064| 3999|sipaccount.cpp:1708 ] Presence enabled for a67b376b942ef87c : false. [1465882511.064| 3999|manager.cpp:1479 ] Saving Configuration to XDG directory /home/user/.config/ring/dring.yml [1465882511.080| 3999|siptransport.cpp:209 ] pjsip transport@0x13012b8 udp 0.0.0.0:5060 [published as 192.168.1.100:5060] -> DESTROY [1465882511.080| 3999|siptransport.cpp:235 ] unmap pjsip transport@0x13012b8 {SipTransport@(nil)} 07:35:11.082 udp0x132ae70 SIP UDP transport destroyed