Re: [sr-dev] [kamailio/kamailio] Problem with re-invite and bye from uas when re-invite fail using topos module (#1571)

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]