[kamailio/kamailio] Problem with re-invite and bye from uas when re-invite fail using topos module (#1571)
<!-- Kamailio Project uses GitHub Issues only for bugs in the code or feature requests.
If you have questions about using Kamailio or related to its configuration file, ask on sr-users mailing list:
* http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
If you have questions about developing extensions to Kamailio or its existing C code, ask on sr-dev mailing list
* http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-dev
Please try to fill this template as much as possible for any issue. It helps the developers to troubleshoot the issue.
If you submit a feature request (or enhancement), you can delete the text of the template and only add the description of what you would like to be added.
If there is no content to be filled in a section, the entire section can be removed.
You can delete the comments from the template sections when filling.
You can delete next line and everything above before submitting (it is a comment). -->
### Description Using an instance of Kamailio with topos module loaded in a simple call scenario beetwin UA. When UAS side sends a re-invite to UAC side and UAC refuse the re-invite, the subsequent re-invite or Bye from UAS will be send by kamailio to UAS and not to UAC.
#### Reproduction 1. Entablish a call from two kamailio clients with topos module loaded 2. In stable state, UAS side send a re-Invite and UAC Side refuse it with 488 status code. 3. the UAS send another re-Invite but kamailio forward it to UAS ad not to UAC (??????) 4. the UAS send Bye but kamailio forward it to UAS (??????)
Without topos the scenario it's ok.
#### Log Messages Below syslog with topos grep.
Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (0, 0) Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060](85) - x_vbranch1: [z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](46) Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:435]: tps_pack_message(): single record routing by proxy Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [sip:10.10.10.1;lr](19) Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [sip:10.10.10.1;lr](17) - bs_contact: [sip:10.10.10.1;lr](17) Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0> Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0#015#012] Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:47 kamailio[15385]: {1 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](46) Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060#015#012] Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jun 20 14:07:47 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0#015#012] Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK7d5f371d](15) Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:47 kamailio[15382]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0](46) Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060#015#012] Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jun 20 14:07:49 kamailio[15387]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0#015#012] Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK7d5f371d](15) Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:49 kamailio[15387]: {2 102 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;branch=z9hG4bK6b403646;rport](58) - x_via2: [](0) - x_vbranch1: [z9hG4bK6b403646](15) Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:07:49 kamailio[15383]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.7bf8866b5be3a47127fef55db63f6475.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK6b403646;rport=5060](85) - x_vbranch1: [z9hG4bK688b.7bf8866b5be3a47127fef55db63f6475.0](46) Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bK688b.7bf8866b5be3a47127fef55db63f6475.0> Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} WARNING: topos [tps_storage.c:400]: tps_storage_record(): no local address - do record routing for all initial requests Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.7bf8866b5be3a47127fef55db63f6475.0#015#012] Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:49 kamailio[15383]: {1 102 ACK 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK1068e7dd1B99AC24](23) Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:calling@10.10.10.133] Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:07:54 kamailio[15384]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24](54) - x_vbranch1: [z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0](46) Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0> Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} WARNING: topos [tps_storage.c:400]: tps_storage_record(): no local address - do record routing for all initial requests Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0#015#012] Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:54 kamailio[15384]: {1 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0;received=10.10.10.1](96) - x_via2: [](0) - x_vbranch1: [z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0](46) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24#015#012] Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0#015#012] Jun 20 14:07:54 kamailio[15389]: {2 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 1) Jun 20 14:07:54 kamailio[15389]: {2 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0](46) Jun 20 14:07:54 kamailio[15389]: {2 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15389]: {2 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15389]: {2 1 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:948]: tps_request_sent(): no x-uuid header - nothing to do Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK1068e7dd1B99AC24](23) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15389]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK1068e7dd1B99AC24](23) Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:07:54 kamailio[15388]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:07:54 kamailio[15400]: DEBUG: topos [tps_storage.c:813]: tps_db_clean_branches(): cleaning expired branch records Jun 20 14:07:54 kamailio[15400]: DEBUG: topos [tps_storage.c:626]: tps_db_clean_dialogs(): cleaning expired dialog records Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK612ee13388A83F02](23) Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:08:02 kamailio[15386]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02](54) - x_vbranch1: [z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](46) Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bKae99.388ff26219073099b423cdf9b636e486.0> Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} WARNING: topos [tps_storage.c:400]: tps_storage_record(): no local address - do record routing for all initial requests Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0#015#012] Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:08:02 kamailio[15386]: {1 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](46) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02#015#012] Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bKae99.388ff26219073099b423cdf9b636e486.0#015#012] Jun 20 14:08:02 kamailio[15382]: {2 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 1) Jun 20 14:08:02 kamailio[15382]: {2 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKae99.388ff26219073099b423cdf9b636e486.0](46) Jun 20 14:08:02 kamailio[15382]: {2 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15382]: {2 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15382]: {2 2 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:948]: tps_request_sent(): no x-uuid header - nothing to do Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK612ee13388A83F02](23) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15382]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK612ee13388A83F02](23) Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:08:02 kamailio[15387]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK4ee32027442C666](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK4ee32027442C666](22) Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:08:02 kamailio[15383]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK4ee32027442C666](53) - x_vbranch1: [z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](46) Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0> Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} WARNING: topos [tps_storage.c:400]: tps_storage_record(): no local address - do record routing for all initial requests Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0#015#012] Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:08:02 kamailio[15383]: {1 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](46) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK4ee32027442C666#015#012] Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0#015#012] Jun 20 14:08:02 kamailio[15384]: {2 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 1) Jun 20 14:08:02 kamailio[15384]: {2 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKbe99.7954cb39228dc2201c69259c871a3ff5.0](46) Jun 20 14:08:02 kamailio[15384]: {2 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15384]: {2 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15384]: {2 3 INVITE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:948]: tps_request_sent(): no x-uuid header - nothing to do Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK4ee32027442C666](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK4ee32027442C666](22) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15384]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK4ee32027442C666](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK4ee32027442C666](22) Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:08:02 kamailio[15389]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKb237f85bB8D0E60A](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKb237f85bB8D0E60A](23) Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:called@10.10.10.84] Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 20 14:08:05 kamailio[15388]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b2a435e-3c19-1#015#012] Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK8e99.a500333534052b9c12d899269c955aec.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKb237f85bB8D0E60A](54) - x_vbranch1: [z9hG4bK8e99.a500333534052b9c12d899269c955aec.0](46) Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no stored record for <z9hG4bK8e99.a500333534052b9c12d899269c955aec.0> Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} WARNING: topos [tps_storage.c:400]: tps_storage_record(): no local address - do record routing for all initial requests Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK8e99.a500333534052b9c12d899269c955aec.0#015#012] Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1#015#012] Jun 20 14:08:05 kamailio[15388]: {1 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK8e99.a500333534052b9c12d899269c955aec.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK8e99.a500333534052b9c12d899269c955aec.0](46) Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKb237f85bB8D0E60A#015#012] Jun 20 14:08:06 kamailio[15385]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK8e99.a500333534052b9c12d899269c955aec.0#015#012] Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKb237f85bB8D0E60A](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKb237f85bB8D0E60A](23) Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 438 Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b2a435e-3c19-1] Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 438 Jun 20 14:08:06 kamailio[15385]: {2 4 BYE 4fbdd2941ef56f9d552456304e557e46@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1#015#012]
#### SIP Traffic ##### UAC to kamailio INVITE sip:called@10.10.10.1 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.133:5060;branch=z9hG4bK7d5f371d;rport Max-Forwards: 70 From: sip:calling@10.10.10.1;tag=as5018bebf To: sip:called@10.10.10.1 Contact: sip:calling@10.10.10.133 Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 102 INVITE User-Agent: abcd UA Date: Thu, 01 Jan 1970 03:07:53 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE Supported: replaces Content-Type: application/sdp Content-Length: 315
##### kamailio to UAS INVITE sip:called@10.10.10.84 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0 Max-Forwards: 69 From: sip:calling@10.10.10.1;tag=as5018bebf To: sip:called@10.10.10.1 Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 102 INVITE User-Agent: abcd UA Date: Thu, 01 Jan 1970 03:07:53 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE Supported: replaces Content-Type: application/sdp Content-Length: 315 Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1
##### UAS to Kamailio SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0 From: sip:calling@10.10.10.1;tag=as5018bebf To: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA CSeq: 102 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 User-Agent: zzzzzz UA Allow-Events: conference,talk,hold Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Length: 0
##### kamailio to UAC SIP/2.0 180 Ringing From: sip:calling@10.10.10.1;tag=as5018bebf To: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA CSeq: 102 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 User-Agent: zzzzzz UA Allow-Events: conference,talk,hold Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Length: 0 Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060 Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1
##### UAS to kamailio SIP/2.0 200 OK Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.276da23c28cfe8037e9da9bbf23e252a.0 From: sip:calling@10.10.10.1;tag=as5018bebf To: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA CSeq: 102 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Supported: replaces,100rel User-Agent: zzzzzz UA Allow-Events: conference,talk,hold Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Type: application/sdp Content-Length: 232
##### kamailio to UAC SIP/2.0 200 OK From: sip:calling@10.10.10.1;tag=as5018bebf To: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA CSeq: 102 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER Supported: replaces,100rel User-Agent: zzzzzz UA Allow-Events: conference,talk,hold Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Type: application/sdp Content-Length: 232 Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK7d5f371d;rport=5060 Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1
##### UAC to kamailio ACK sip:atpsh-5b2a435e-3c19-1@10.10.10.1 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.133:5060;branch=z9hG4bK6b403646;rport Max-Forwards: 70 From: sip:calling@10.10.10.1;tag=as5018bebf To: sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA Contact: sip:calling@10.10.10.133 Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 102 ACK User-Agent: abcd UA Content-Length: 0
##### kamailio to UAS ACK sip:called@10.10.10.84 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK688b.7bf8866b5be3a47127fef55db63f6475.0 Max-Forwards: 69 From: sip:calling@10.10.10.1;tag=as5018bebf To: sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 102 ACK User-Agent: abcd UA Content-Length: 0 Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1
##### re-invite from UAS to Kamailio INVITE sip:btpsh-5b2a435e-3c19-1@10.10.10.1;transport=udp SIP/2.0 Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 1 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Supported: replaces,100rel Allow-Events: conference,talk,hold Max-Forwards: 70 Content-Type: application/sdp Content-Length: 232
##### re-invite from kamailio to UAC INVITE sip:calling@10.10.10.133 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 1 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Supported: replaces,100rel Allow-Events: conference,talk,hold Max-Forwards: 69 Content-Type: application/sdp Content-Length: 232 Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1
##### UAC to kamailio SIP/2.0 488 Not acceptable here Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0;received=10.10.10.1 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 1 INVITE Server: abcd UA Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE Supported: replaces Content-Length: 0
##### kamailio to UAC ACK sip:calling@10.10.10.133 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKde99.8bda9a7ca0c860e6d97665f911df7c67.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 1 ACK Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Max-Forwards: 69 Content-Length: 0
##### Kamailio to UAS SIP/2.0 488 Not acceptable here From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 CSeq: 1 INVITE Server: abcd UA Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE Supported: replaces Content-Length: 0 Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24 Contact: sip:btpsh-5b2a435e-3c19-1@10.10.10.1
##### UAS to Kamailio ACK sip:btpsh-5b2a435e-3c19-1@10.10.10.1;transport=udp SIP/2.0 Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK1068e7dd1B99AC24 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 1 ACK Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Max-Forwards: 70 Content-Length: 0
##### Re-inivte from UAS to Kamailio INVITE sip:btpsh-5b2a435e-3c19-1@10.10.10.1;transport=udp SIP/2.0 Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK612ee13388A83F02 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 2 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Supported: replaces,100rel Allow-Events: conference,talk,hold Max-Forwards: 70 Content-Type: application/sdp Content-Length: 390
##### Kamailio forward re-invite to UAS ?????? INVITE sip:called@10.10.10.84 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 2 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Supported: replaces,100rel Allow-Events: conference,talk,hold Max-Forwards: 69 Content-Type: application/sdp Content-Length: 390 Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1
##### UAS send fail to Kamailio SIP/2.0 491 Request Pending Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKae99.388ff26219073099b423cdf9b636e486.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 2 INVITE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Length: 0
##### UAS sends Bye to kamailio BYE sip:btpsh-5b2a435e-3c19-1@10.10.10.1;transport=udp SIP/2.0 Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKb237f85bB8D0E60A From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 4 BYE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 Contact: sip:called@10.10.10.84 User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Max-Forwards: 70 Content-Length: 0
##### kamailio forward bye to UAS ????? BYE sip:called@10.10.10.84 SIP/2.0 Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK8e99.a500333534052b9c12d899269c955aec.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 4 BYE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Max-Forwards: 69 Content-Length: 0 Contact: sip:atpsh-5b2a435e-3c19-1@10.10.10.1
##### UAS sends fail to kamailio SIP/2.0 481 Call Leg/Transaction Does Not Exist Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK8e99.a500333534052b9c12d899269c955aec.0 From: "kamailio-pc" sip:called@10.10.10.1;tag=2AFD9F0B-7120A8FA To: sip:calling@10.10.10.1;tag=as5018bebf CSeq: 4 BYE Call-ID: 4fbdd2941ef56f9d552456304e557e46@10.10.10.133 User-Agent: zzzzzz UA Accept-Language: it-it,it;q=0.9,en;q=0.8 Content-Length: 0
### Additional Information
* **Kamailio Version** - output of `kamailio -v`
version: kamailio 5.2.0-dev6 (x86_64/linux) flags: STATS: Off, USE_TCP, USE_TLS, USE_SCTP, TLS_HOOKS, USE_RAW_SOCKS, DISABLE_NAGLE, USE_MCAST, DNS_IP_HACK, SHM_MEM, SHM_MMAP, PKG_MALLOC, Q_MALLOC, F_MALLOC, TLSF_MALLOC, DBG_SR_MEMORY, USE_FUTEX, FAST_LOCK-ADAPTIVE_WAIT, USE_DNS_CACHE, USE_DNS_FAILOVER, USE_NAPTR, USE_DST_BLACKLIST, HAVE_RESOLV_RES ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16, MAX_URI_SIZE 1024, BUF_SIZE 65535, DEFAULT PKG_SIZE 8MB poll method support: poll, epoll_lt, epoll_et, sigio_rt, select. id: unknown compiled on 14:05:06 Jun 20 2018 with gcc 5.4.0
The only reason could be that the Contact address is updated in the wrong field after the re-INVITE.
Can you watch the records in database table topos_d and look at a_contact and b_contact fields before and after re-INVITE?
I also pushed a commit to mater branch to log how contact addresses are mapped, so you can fetch the latest git and try with it, then besides the database records for topos_d you can attach fresh log messages to match the values from database.
Thank's for your reply. I see that the a_contact field in topos_d table have the re-Invite contact value and it will be update only when will be receive 200 ok. I think that the problem is in db update management when requests within dialog receives failure/redirect final reply. I try to comment the code where del topos_d will be update at re-invite receive and my scenario works. I don't know if this is a valid modify.
Here are the required traces with master version:
**topos_d during call in stable state**
id: 4 rectime: 2018-06-25 10:10:37 s_method: INVITE s_cseq: 102 a_callid: 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133 a_uuid: atpsh-5b309a9f-35ed-1 b_uuid: btpsh-5b309a9f-35ed-1 a_contact: sip:0861772506@10.10.10.133 b_contact: sip:200@10.10.10.84 as_contact: sip:atpsh-5b309a9f-35ed-1@10.10.10.1 bs_contact: sip:btpsh-5b309a9f-35ed-1@10.10.10.1 a_tag: as159ff76a b_tag: 8A1124D-F7DB8FD4 a_rr: sip:10.10.10.1;lr b_rr: 2 s_rr: iflags: a_uri: b_uri: r_uri: a_srcaddr: b_srcaddr: a_socket: b_socket:
**topos_d after re-invite failure** id: 4 rectime: 2018-06-25 10:10:37 s_method: INVITE s_cseq: 102 a_callid: 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133 a_uuid: atpsh-5b309a9f-35ed-1 b_uuid: btpsh-5b309a9f-35ed-1 **a_contact: sip:200@10.10.10.84** b_contact: sip:200@10.10.10.84 as_contact: sip:atpsh-5b309a9f-35ed-1@10.10.10.1 bs_contact: sip:btpsh-5b309a9f-35ed-1@10.10.10.1 a_tag: as159ff76a b_tag: 8A1124D-F7DB8FD4 a_rr: sip:10.10.10.1;lr b_rr: 2 s_rr: iflags: a_uri: b_uri: r_uri: a_srcaddr: b_srcaddr: a_socket: b_socket:
Syslog trace grepped for "topos":
**when Enstablish call** Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (0, 0) Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK4860a41f;rport=5060](85) - x_vbranch1: [z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](46) Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:435]: tps_pack_message(): single record routing by proxy Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [sip:10.10.10.1;lr](19) Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [sip:10.10.10.1;lr](17) - bs_contact: [sip:10.10.10.1;lr](17) Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0> Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [sip:0861772506@10.10.10.133] bcontact: [] Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0#015#012] Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:10:37 kamailio[13805]: {1 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](46) Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [] bcontact: [sip:200@10.10.10.84] Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK4860a41f;rport=5060#015#012] Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jun 25 10:10:37 kamailio[13807]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0#015#012] Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK4860a41f;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK4860a41f](15) Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:10:37 kamailio[13807]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [] bcontact: [sip:200@10.10.10.84] Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0](46) Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [] bcontact: [sip:200@10.10.10.84] Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK4860a41f;rport=5060#015#012] Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jun 25 10:10:39 kamailio[13808]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bKf9bf.5ca6ea47b4e30bae0c42b77f8e6fdb3a.0#015#012] Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK4860a41f;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK4860a41f](15) Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:10:39 kamailio[13808]: {2 102 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [] bcontact: [sip:200@10.10.10.84] Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;branch=z9hG4bK23de55ba;rport](58) - x_via2: [](0) - x_vbranch1: [z9hG4bK23de55ba](15) Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:200@10.10.10.84] Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 25 10:10:39 kamailio[13803]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b309a9f-35ed-1#015#012] Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.70b67570f198c08f4c8bfccda86ed225.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK23de55ba;rport=5060](85) - x_vbranch1: [z9hG4bKf9bf.70b67570f198c08f4c8bfccda86ed225.0](46) Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bKf9bf.70b67570f198c08f4c8bfccda86ed225.0> Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [sip:0861772506@10.10.10.133] bcontact: [] Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bKf9bf.70b67570f198c08f4c8bfccda86ed225.0#015#012] Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:10:39 kamailio[13803]: {1 102 ACK 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:10:50 kamailio[13811]: DEBUG: topos [tps_storage.c:818]: tps_db_clean_branches(): cleaning expired branch records Jun 25 10:10:50 kamailio[13811]: DEBUG: topos [tps_storage.c:631]: tps_db_clean_dialogs(): cleaning expired dialog records
**when send re-invite:** Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe96e1a173BDE1396](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKe96e1a173BDE1396](23) Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 25 10:11:17 kamailio[13801]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b309a9f-35ed-1#015#012] Jun 25 10:11:17 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jun 25 10:11:17 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe96e1a173BDE1396](54) - x_vbranch1: [z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0](46) Jun 25 10:11:17 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:17 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:17 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0> Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes acontact: [sip:200@10.10.10.84] bcontact: [] Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0#015#012] Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no acontact: [sip:200@10.10.10.84] bcontact: [sip:200@10.10.10.84] Jun 25 10:11:18 kamailio[13801]: {1 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0;received=10.10.10.1](96) - x_via2: [](0) - x_vbranch1: [z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0](46) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe96e1a173BDE1396#015#012] Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0#015#012] Jun 25 10:11:18 kamailio[13805]: {2 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 1) Jun 25 10:11:18 kamailio[13805]: {2 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK50dd.2ffa072d1cfcb5cc4d65a70c44dbf472.0](46) Jun 25 10:11:18 kamailio[13805]: {2 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:18 kamailio[13805]: {2 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:18 kamailio[13805]: {2 1 INVITE 561fa4601e12e9e0174a5a5447aa3910@10.10.10.133} DEBUG: topos [tps_msg.c:948]: tps_request_sent(): no x-uuid header - nothing to do Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:1031]: tps_response_sent(): handling outgoing response Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe96e1a173BDE1396](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKe96e1a173BDE1396](23) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:1061]: tps_response_sent(): loaded branch a_uuid [atpsh-5b309a9f-35ed-1] Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:11:18 kamailio[13805]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b309a9f-35ed-1@10.10.10.1#015#012] Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe96e1a173BDE1396](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKe96e1a173BDE1396](23) Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 206 Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 206 Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:200@10.10.10.84] Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jun 25 10:11:18 kamailio[13806]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b309a9f-35ed-1#015#012]
Hi, have you news about issue?
Traveling for a while, hope to get back to it in a matter of days.
I just pushed a commit to master, try with it and if still fails, attach again the debug messages.
Thank's, now the scenario works!
Here are the required traces with master version:
**topos_d during call in stable state** id: 9 rectime: 2018-07-03 10:43:06 s_method: INVITE s_cseq: 102 a_callid: 418f41b41b0cdca64ec79721696c87bf@10.10.10.133 a_uuid: atpsh-5b3b2d27-113d-1 b_uuid: btpsh-5b3b2d27-113d-1 a_contact: sip:0861772506@10.10.10.133 b_contact: sip:200@10.10.10.84 as_contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1 bs_contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1 a_tag: as0f1ca199 b_tag: 7E227A8-6B097E05 a_rr: b_rr: s_rr:sip:10.10.10.1;lr iflags:2 a_uri: b_uri: r_uri: a_srcaddr: b_srcaddr: a_socket: b_socket:
**topos_d after re-invite failure** id: 9 rectime: 2018-07-03 10:43:06 s_method:INVITE s_cseq:102 a_callid: 418f41b41b0cdca64ec79721696c87bf@10.10.10.133 a_uuid: atpsh-5b3b2d27-113d-1 b_uuid: btpsh-5b3b2d27-113d-1 a_contact: sip:0861772506@10.10.10.133 b_contact: sip:200@10.10.10.84 as_contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1 bs_contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1 a_tag: as0f1ca199 b_tag: 7E227A8-6B097E05 a_rr: b_rr: s_rr:sip:10.10.10.1;lr iflags:2 a_uri: b_uri: r_uri: a_srcaddr: b_srcaddr: a_socket: b_socket:
**topos_d after re-invite AND it's OK!!!** id: 9 rectime: 2018-07-03 10:43:06 s_method:INVITE s_cseq:102 a_callid: 418f41b41b0cdca64ec79721696c87bf@10.10.10.133 a_uuid: atpsh-5b3b2d27-113d-1 b_uuid: btpsh-5b3b2d27-113d-1 a_contact: sip:0861772506@10.10.10.133 b_contact: sip:200@10.10.10.84 as_contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1 bs_contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1 a_tag: as0f1ca199 b_tag: 7E227A8-6B097E05 a_rr: b_rr: s_rr:sip:10.10.10.1;lr iflags:2 a_uri: b_uri: r_uri: a_srcaddr: b_srcaddr: a_socket: b_socket:
**Syslog trace grepped for "topos":**
**when Enstablish call** Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (0, 0) Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK353bad19;rport=5060](85) - x_vbranch1: [z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](46) Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:435]: tps_pack_message(): single record routing by proxy Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [sip:10.10.10.1;lr](19) Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [sip:10.10.10.1;lr](17) - bs_contact: [sip:10.10.10.1;lr](17) Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK10af.740a4af420653c69ff779844c8d56249.0> Jul 3 10:43:06 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [sip:0861772506@10.10.10.133] - bcontact: [] Jul 3 10:43:07 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.740a4af420653c69ff779844c8d56249.0#015#012] Jul 3 10:43:07 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:07 kamailio[4413]: {1 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](46) Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK353bad19;rport=5060#015#012] Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jul 3 10:43:07 kamailio[4414]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK10af.740a4af420653c69ff779844c8d56249.0#015#012] Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1033]: tps_response_sent(): handling outgoing response Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK353bad19;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK353bad19](15) Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1063]: tps_response_sent(): loaded branch a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:07 kamailio[4414]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK10af.740a4af420653c69ff779844c8d56249.0](46) Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK353bad19;rport=5060#015#012] Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Record-Route: sip:10.10.10.1;lr#015#012] Jul 3 10:43:09 kamailio[4411]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK10af.740a4af420653c69ff779844c8d56249.0#015#012] Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1033]: tps_response_sent(): handling outgoing response Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK353bad19;rport=5060](85) - x_via2: [](0) - x_vbranch1: [z9hG4bK353bad19](15) Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [sip:10.10.10.1;lr](19) - s_rr: [](0) Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1063]: tps_response_sent(): loaded branch a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:09 kamailio[4411]: {2 102 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.133:5060;branch=z9hG4bK5f2f558b;rport](58) - x_via2: [](0) - x_vbranch1: [z9hG4bK5f2f558b](15) Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:200@10.10.10.84] Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:43:09 kamailio[4410]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012] Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.acf1b5430261d0be1c800edbc392598a.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.133:5060;received=10.10.10.133;branch=z9hG4bK5f2f558b;rport=5060](85) - x_vbranch1: [z9hG4bK10af.acf1b5430261d0be1c800edbc392598a.0](46) Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK10af.acf1b5430261d0be1c800edbc392598a.0> Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: yes - acontact: [sip:0861772506@10.10.10.133] - bcontact: [] Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK10af.acf1b5430261d0be1c800edbc392598a.0#015#012] Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:09 kamailio[4410]: {1 102 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304
**when send re-invite and receive failure:** Jul 3 10:43:41 kamailio[4418]: DEBUG: topos [tps_storage.c:818]: tps_db_clean_branches(): cleaning expired branch records Jul 3 10:43:41 kamailio[4418]: DEBUG: topos [tps_storage.c:631]: tps_db_clean_dialogs(): cleaning expired dialog records Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK6bb2b6e4942DD51](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK6bb2b6e4942DD51](22) Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:43:48 kamailio[4415]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012] Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK6bb2b6e4942DD51](53) - x_vbranch1: [z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0](46) Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0> Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0#015#012] Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:43:48 kamailio[4415]: {1 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0;received=10.10.10.1](96) - x_via2: [](0) - x_vbranch1: [z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0](46) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK6bb2b6e4942DD51#015#012] Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0#015#012] Jul 3 10:43:48 kamailio[4409]: {2 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 1) Jul 3 10:43:48 kamailio[4409]: {2 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0](76) - x_via2: [](0) - x_vbranch1: [z9hG4bK76bd.493adbe3e00e9716542e8704ac6216eb.0](46) Jul 3 10:43:48 kamailio[4409]: {2 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4409]: {2 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4409]: {2 1 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:948]: tps_request_sent(): no x-uuid header - nothing to do Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:1033]: tps_response_sent(): handling outgoing response Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK6bb2b6e4942DD51](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK6bb2b6e4942DD51](22) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:1063]: tps_response_sent(): loaded branch a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:48 kamailio[4409]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK6bb2b6e4942DD51](53) - x_via2: [](0) - x_vbranch1: [z9hG4bK6bb2b6e4942DD51](22) Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:43:48 kamailio[4408]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012]
**when send re-invite AND it's OK!!!:**
Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe8bcfc426061E3B7](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKe8bcfc426061E3B7](23) Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:44:29 kamailio[4412]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012] Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe8bcfc426061E3B7](54) - x_vbranch1: [z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0](46) Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0> Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0#015#012] Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:44:29 kamailio[4412]: {1 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0;received=10.10.10.1](96) - x_via2: [](0) - x_vbranch1: [z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0](46) Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [sip:0861772506@10.10.10.133] - bcontact: [] Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe8bcfc426061E3B7#015#012] Jul 3 10:44:29 kamailio[4411]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK46bd.3f474fd6aa9c96e918a81e16a59ef9d3.0#015#012] Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1033]: tps_response_sent(): handling outgoing response Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bKe8bcfc426061E3B7](54) - x_via2: [](0) - x_vbranch1: [z9hG4bKe8bcfc426061E3B7](23) Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1063]: tps_response_sent(): loaded branch a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:44:29 kamailio[4411]: {2 2 INVITE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [sip:0861772506@10.10.10.133] - bcontact: [] Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7fcd3d1822A2D1B5](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK7fcd3d1822A2D1B5](23) Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:44:30 kamailio[4410]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012] Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK46bd.7ad043b4a18e0ae589cd6849ac95635b.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7fcd3d1822A2D1B5](54) - x_vbranch1: [z9hG4bK46bd.7ad043b4a18e0ae589cd6849ac95635b.0](46) Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK46bd.7ad043b4a18e0ae589cd6849ac95635b.0> Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK46bd.7ad043b4a18e0ae589cd6849ac95635b.0#015#012] Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:44:30 kamailio[4410]: {1 2 ACK 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:44:41 kamailio[4418]: DEBUG: topos [tps_storage.c:818]: tps_db_clean_branches(): cleaning expired branch records Jul 3 10:44:41 kamailio[4418]: DEBUG: topos [tps_storage.c:631]: tps_db_clean_dialogs(): cleaning expired dialog records
**when send Bye:** Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:742]: tps_request_received(): handling incoming request Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7a45c19e6E1E38A3](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK7a45c19e6E1E38A3](23) Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:816]: tps_request_received(): r-uri updated to: [sip:0861772506@10.10.10.133] Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Route: sip:10.10.10.1;lr#015#012] Jul 3 10:45:01 kamailio[4415]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XUID: atpsh-5b3b2d27-113d-1#015#012] Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling outgoing request (1, 0) Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK56bd.201457ffd9e06b936335351423c54516.0](76) - x_via2: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7a45c19e6E1E38A3](54) - x_vbranch1: [z9hG4bK56bd.201457ffd9e06b936335351423c54516.0](46) Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:972]: tps_db_load_branch(): no stored record for <z9hG4bK56bd.201457ffd9e06b936335351423c54516.0> Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:363]: tps_storage_link_msg(): downstream: no - acontact: [] - bcontact: [sip:200@10.10.10.84] Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(1) - [Via: SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK56bd.201457ffd9e06b936335351423c54516.0#015#012] Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:atpsh-5b3b2d27-113d-1@10.10.10.1#015#012] Jul 3 10:45:01 kamailio[4415]: {1 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:45:01 kamailio[4409]: DEBUG: topos [tps_msg.c:868]: tps_response_received(): handling incoming response Jul 3 10:45:01 kamailio[4409]: DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.1;branch=z9hG4bK56bd.201457ffd9e06b936335351423c54516.0;received=10.10.10.1](96) - x_via2: [](0) - x_vbranch1: [z9hG4bK56bd.201457ffd9e06b936335351423c54516.0](46) Jul 3 10:45:01 kamailio[4409]: DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:45:01 kamailio[4409]: DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:45:01 kamailio[4409]: DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:45:02 kamailio[4409]: DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded dialog a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:45:02 kamailio[4409]: DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:45:02 kamailio[4409]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Via: SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7a45c19e6E1E38A3#015#012] Jul 3 10:45:02 kamailio[4409]: DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [P-SR-XBranch: z9hG4bK56bd.201457ffd9e06b936335351423c54516.0#015#012] Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1033]: tps_response_sent(): handling outgoing response Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/UDP 10.10.10.84;branch=z9hG4bK7a45c19e6E1E38A3](54) - x_via2: [](0) - x_vbranch1: [z9hG4bK7a45c19e6E1E38A3](23) Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps lock get: 304 Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:1063]: tps_response_sent(): loaded branch a_uuid [atpsh-5b3b2d27-113d-1] Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): tps lock release: 304 Jul 3 10:45:02 kamailio[4409]: {2 3 BYE 418f41b41b0cdca64ec79721696c87bf@10.10.10.133} DEBUG: topos [tps_msg.c:182]: tps_add_headers(): adding to headers(0) - [Contact: sip:btpsh-5b3b2d27-113d-1@10.10.10.1#015#012]
Thanks for testing and feedback, it will be backported.
Closed #1571.
-
Daniel-Constantin Mierla -
giupand