[OpenSIPStack] SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing
Brought to you by:
joegenbaclor
From: <ope...@op...> - 2008-04-01 11:17:44
|
I hope someone can help about the next error. When I try to connet to the Core-IMS it´s sending "400 Bad Request - P-Visited-Network-ID header missing" ¿What is the problem? ¿Any alternative? Thanks in advance. *Configuration basic:* Proxy Only Mode or B2BOnlyMode Opensbc listener: sip:10.1.1.1:5060 Client SIP:10.2.2.2 Proxy-IMS-Core:10.3.3.3 B2Broutes: [sip:*@oprobe.test] sip:10.3.3.3:4060 [sip:*] sip:10.1.1.1:5060 --------------------------------- *comunication´s dump*------------------------------------------- No. Time Source Destination Protocol Info 18401 140.730795 10.2.2.2 10.1.1.1 SIP Request: REGISTER sip:probe.test No. Time Source Destination Protocol Info Internet Protocol, Src: 10.2.2.2 (10.2.2.2), Dst: 10.1.1.1 (10.1.1.1) User Datagram Protocol, Src Port: 22326 (22326), Dst Port: sip (5060) No. Time Source Destination Protocol Info 18410 140.740088 10.1.1.1 10.2.2.2 SIP Status: 100 Trying (0 bindings) Frame 18410 (411 bytes on wire, 411 bytes captured) Internet Protocol, Src: 10.1.1.1 (10.1.1.1), Dst: 10.2.2.2 (10.2.2.2) User Datagram Protocol, Src Port: sip (5060), Dst Port: 22326 (22326) No. Time Source Destination Protocol Info 18411 140.742465 10.1.1.1 10.3.3.3 SIP Request: REGISTER sip:probe.test Frame 18411 (768 bytes on wire, 768 bytes captured) Internet Protocol, Src: 10.1.1.1 (10.1.1.1), Dst: 10.3.3.3 (10.3.3.3) User Datagram Protocol, Src Port: sip (5060), Dst Port: sip (5060) No. Time Source Destination Protocol Info 18412 140.743310 10.3.3.3 10.1.1.1 SIP Status: 400 Bad Request - P-Visited-Network-ID header missing (0 bindings) Frame 18412 (845 bytes on wire, 845 bytes captured) Internet Protocol, Src: 10.3.3.3 (10.3.3.3), Dst: 10.1.1.1 (10.1.1.1) User Datagram Protocol, Src Port: sip (5060), Dst Port: sip (5060) No. Time Source Destination Protocol Info 18413 140.746147 10.1.1.1 10.2.2.2 SIP Status: 400 Bad Request - P-Visited-Network-ID header missing (0 bindings) Frame 18413 (699 bytes on wire, 699 bytes captured) Internet Protocol, Src: 10.1.1.1 (10.1.1.1), Dst: 10.2.2.2 (10.2.2.2) User Datagram Protocol, Src Port: sip (5060), Dst Port: 22326 (22326) -------------------------------------------------------------------------------------------------------------- *OpenSBC log level 5* 335290:41:06.549 INF: [CID=0x0f49] <<< REGISTER sip:probe.test SIP/2.0 SRC: 10.2.2.2:22326:UDP enc=0 bytes=545 335290:41:06.549 DBG: [CID=0x0f49] 335290:41:06.549 DBG: [CID=0x0f49] REGISTER sip:probe.test SIP/2.0 335290:41:06.549 DBG: [CID=0x0f49] From: "Javi" <sip:javier@probe.test>;tag=fc6f8027 335290:41:06.549 DBG: [CID=0x0f49] To: "Javi" <sip:javier@probe.test> 335290:41:06.549 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.2.2.2:22326;branch=z9hG4bK-d87543-842bd60df3018b7b-1--d87543- 335290:41:06.549 DBG: [CID=0x0f49] CSeq: 1 REGISTER 335290:41:06.549 DBG: [CID=0x0f49] Call-ID: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.549 DBG: [CID=0x0f49] Contact: <sip:javier@10.2.2.2:22326;rinstance=5bcbbe6b157c63cf> 335290:41:06.549 DBG: [CID=0x0f49] User-Agent: X-Lite release 1011s stamp 41150 335290:41:06.549 DBG: [CID=0x0f49] Expires: 3600 335290:41:06.549 DBG: [CID=0x0f49] Max-Forwards: 70 335290:41:06.549 DBG: [CID=0x0f49] Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 335290:41:06.549 DBG: [CID=0x0f49] Content-Length: 0 335290:41:06.549 DBG: [CID=0x0f49] 335290:41:06.549 DBG: [CID=0x0f49] 335290:41:06.549 DBG: [CID=0x0f49] Finding transaction for REGISTER sip:probe.test SIP/2.0 335290:41:06.549 DBG: [CID=0x0f49] Setting Transaction ID to NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK-d87543-842bd60df3018b7b-1--d87543-|REGISTER 335290:41:06.549 DBG: [CID=0x0f49] 335290:41:06.549 DBG: [CID=0x0f49] *** CREATING TRANSACTION (NIST) *** 335290:41:06.549 DBG: [CID=0x0f49] Message: REGISTER sip:probe.test SIP/2.0 335290:41:06.549 DBG: [CID=0x0f49] Call-Id: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.549 DBG: [CID=0x0f49] 335290:41:06.549 DTL: [CID=0x0f49] NIST(160656374) *** CREATED *** - NIST|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK-d87543-842bd60df3018b7b-1--d87543-|REGISTER 335290:41:06.549 PWL: [CID=0x0000] PWLib File handle low water mark set: 101 Thread unblock pipe 335290:41:06.549 PWL: [CID=0x0000] PWLib Created thread 0x85fe270 Garbage Collector 335290:41:06.549 PWL: [CID=0x0000] PWLib File handle high water mark set: 247 Thread unblock pipe 335290:41:06.549 PWL: [CID=0x0000] PWLib Created thread 0x85fe878 GC::Collector 335290:41:06.549 PWL: [CID=0x0000] PWLib Started thread 0x85fe878 GC::Collector 335290:41:06.549 PWL: [CID=0x0000] PWLib Thread high water mark set: 118 335290:41:06.549 DTL: [CID=0x0f49] NIST(160656374) Event(SIPMessage) - REGISTER sip:probe.test SIP/2.0 335290:41:06.549 DBG: [CID=0x0f49] TRANSACTION: (NIST) REGISTER sip:probe.test SIP/2.0 State: 0 335290:41:06.550 DTL: [CID=0x0f49] NIST(160656374) StateIdle->StateTrying 335290:41:06.550 DBG: [CID=0x0f49] Event: SIPStack::Enqueue(REGISTER sip:probe.test SIP/2.0) 335290:41:06.550 PWL: [CID=0x0000] PWLib Started thread 0x85fe270 Garbage Collector 335290:41:06.550 DBG: [CID=0x0f49] Event: B2BUserAgent::ProcessEvent( REGISTER sip:probe.test SIP/2.0 ) 335290:41:06.555 DTL: [CID=0x0f49] Event: ---> Inbound - REGISTER sip:probe.test SIP/2.0 335290:41:06.555 DBG: [CID=0x0f49] Session CREATED 335290:41:06.556 INF: [CID=0x0f49] *** CREATED *** PROXY Session NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.556 PWL: [CID=0x0000] PWLib File handle high water mark set: 249 Thread unblock pipe 335290:41:06.556 PWL: [CID=0x0000] PWLib Created thread 0xb6e0c330 Garbage Collector 335290:41:06.556 PWL: [CID=0x0000] PWLib File handle high water mark set: 251 Thread unblock pipe 335290:41:06.556 PWL: [CID=0x0000] PWLib Created thread 0xb6e0c948 GC::Collector 335290:41:06.556 PWL: [CID=0x0000] PWLib Thread high water mark set: 119 335290:41:06.556 PWL: [CID=0x0000] PWLib Thread high water mark set: 120 335290:41:06.556 DBG: [CID=0x0f49] *** MESSAGE ARRIVAL *** for SIP Session NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.556 DTL: [CID=0x0f49] Found NIST|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK-d87543-842bd60df3018b7b-1--d87543-|REGISTER for SIP/2.0 100 Trying 335290:41:06.556 PWL: [CID=0x0000] PWLib Started thread 0xb6e0c948 GC::Collector 335290:41:06.556 DTL: [CID=0x0f49] NIST(160656374) Event(SIPMessage) - SIP/2.0 100 Trying 335290:41:06.556 PWL: [CID=0x0000] PWLib Started thread 0xb6e0c330 Garbage Collector 335290:41:06.557 DBG: [CID=0x0f49] TRANSACTION: (NIST) SIP/2.0 100 Trying State: 1 335290:41:06.557 DTL: [CID=0x0f49] NIST(160656374) StateTrying->StateProceeding 335290:41:06.557 INF: [CID=0x0f49] >>> SIP/2.0 100 Trying DST: 10.2.2.2:22326:UDP SRC: 10.1.1.1:5060 enc=0 bytes=369 335290:41:06.557 DBG: [CID=0x0f49] 335290:41:06.557 DBG: [CID=0x0f49] SIP/2.0 100 Trying 335290:41:06.557 DBG: [CID=0x0f49] From: "Javi" <sip:javier@probe.test>;tag=fc6f8027 335290:41:06.557 DBG: [CID=0x0f49] To: "Javi" <sip:javier@probe.test> 335290:41:06.557 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.2.2.2:22326;iid=18308;branch=z9hG4bK-d87543-842bd60df3018b7b-1--d87543-;rport=22326;received=10.2.2.2 335290:41:06.557 DBG: [CID=0x0f49] CSeq: 1 REGISTER 335290:41:06.557 DBG: [CID=0x0f49] Call-ID: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.557 DBG: [CID=0x0f49] Server: OpenSIPStack-1.1.7-22 335290:41:06.557 DBG: [CID=0x0f49] Content-Length: 0 335290:41:06.557 DBG: [CID=0x0f49] 335290:41:06.557 DBG: [CID=0x0f49] 335290:41:06.557 PWL: [CID=0x0000] Using Iface: 10.1.1.1 to send to Dest: 10.2.2.2 335290:41:06.558 INF: [CID=0x0f49] Routing REGISTER for URI sip:javier@probe.test 335290:41:06.558 PWL: [CID=0x0000] *** NO STATIC ROUTE DEFINED *** From: sip:javier@probe.test Target: sip:javier@probe.test 335290:41:06.558 DBG: [CID=0x06cb] CREATED via=10.1.1.1:5060 for target=10.3.3.3 protocol=UDP 335290:41:06.558 DBG: [CID=0x0f49] Proxying request REGISTER sip:probe.test SIP/2.0 335290:41:06.558 DBG: [CID=0x0f49] Finding transaction for REGISTER sip:probe.test SIP/2.0 335290:41:06.558 DBG: [CID=0x0f49] Setting Transaction ID to NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER 335290:41:06.558 DBG: [CID=0x0f49] 335290:41:06.558 DBG: [CID=0x0f49] *** CREATING TRANSACTION (NICT) *** 335290:41:06.558 DBG: [CID=0x0f49] Message: REGISTER sip:probe.test SIP/2.0 335290:41:06.558 DBG: [CID=0x0f49] Call-Id: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.558 DBG: [CID=0x0f49] 335290:41:06.558 DTL: [CID=0x0f49] NICT(160656375) *** CREATED *** - NICT|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER 335290:41:06.559 DTL: [CID=0x0f49] NICT(160656375) Event(SIPMessage) - REGISTER sip:probe.test SIP/2.0 335290:41:06.559 DBG: [CID=0x0f49] TRANSACTION: (NICT) REGISTER sip:probe.test SIP/2.0 State: 0 335290:41:06.559 DTL: [CID=0x0f49] NICT(160656375) StateIdle->StateTrying(REGISTER sip:probe.test SIP/2.0) 335290:41:06.559 DBG: [CID=0x0f49] NICT(160656375) Timer E( 500 ms ) STARTED 335290:41:06.559 DBG: [CID=0x0f49] NICT(160656375) Timer F( 10000 ms ) STARTED 335290:41:06.559 INF: [CID=0x0f49] >>> REGISTER sip:probe.test SIP/2.0 DST: 10.3.3.3:5060:UDP SRC: 10.1.1.1:5060 enc=0 bytes=726 335290:41:06.560 DBG: [CID=0x0f49] 335290:41:06.560 DBG: [CID=0x0f49] REGISTER sip:probe.test SIP/2.0 335290:41:06.560 DBG: [CID=0x0f49] From: "Javi" <sip:javier@probe.test>;tag=fc6f8027 335290:41:06.560 DBG: [CID=0x0f49] To: "Javi" <sip:javier@probe.test> 335290:41:06.560 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.1.1.1:5060;iid=18308;branch=z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c;uas-addr=10.3.3.3;rport 335290:41:06.560 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.2.2.2:22326;branch=z9hG4bK-d87543-842bd60df3018b7b-1--d87543-;rport=22326;received=10.2.2.2 335290:41:06.560 DBG: [CID=0x0f49] CSeq: 1 REGISTER 335290:41:06.560 DBG: [CID=0x0f49] Call-ID: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.560 DBG: [CID=0x0f49] Contact: <sip:javier@10.2.2.2:22326;rinstance=5bcbbe6b157c63cf> 335290:41:06.560 DBG: [CID=0x0f49] User-Agent: X-Lite release 1011s stamp 41150 335290:41:06.560 DBG: [CID=0x0f49] Expires: 3600 335290:41:06.560 DBG: [CID=0x0f49] Max-Forwards: 69 335290:41:06.560 DBG: [CID=0x0f49] Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 335290:41:06.560 DBG: [CID=0x0f49] Content-Length: 0 335290:41:06.560 DBG: [CID=0x0f49] 335290:41:06.560 DBG: [CID=0x0f49] 335290:41:06.560 PWL: [CID=0x0000] Using Iface: 10.1.1.1 to send to Dest: 10.3.3.3 335290:41:06.561 INF: [CID=0x0f49] <<< SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing SRC: 10.3.3.3:5060:UDP enc=0 bytes=803 335290:41:06.561 DBG: [CID=0x0f49] 335290:41:06.561 DBG: [CID=0x0f49] SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.561 DBG: [CID=0x0f49] From: "Javi" <sip:javier@probe.test>;tag=fc6f8027 335290:41:06.561 DBG: [CID=0x0f49] To: "Javi" <sip:javier@probe.test>;tag=52d9d80fa1acefdf01b269454b0bf1a1-6137 335290:41:06.561 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.1.1.1:5060;iid=18308;branch=z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c;uas-addr=10.3.3.3;rport=5060 335290:41:06.561 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.2.2.2:22326;branch=z9hG4bK-d87543-842bd60df3018b7b-1--d87543-;rport=22326;received=10.2.2.2 335290:41:06.561 DBG: [CID=0x0f49] CSeq: 1 REGISTER 335290:41:06.561 DBG: [CID=0x0f49] Call-ID: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.561 DBG: [CID=0x0f49] Server: Sip EXpress router (2.1.0-dev1 OpenIMSCore (i386/linux)) 335290:41:06.561 DBG: [CID=0x0f49] Warning: 392 10.3.3.3:5060 "Noisy feedback tells: pid=19841 req_src_ip=10.1.1.1 req_src_port=5060 in_uri=sip:probe.test out_uri=sip:probe.test via_cnt==2" 335290:41:06.561 DBG: [CID=0x0f49] Content-Length: 0 335290:41:06.561 DBG: [CID=0x0f49] 335290:41:06.561 DBG: [CID=0x0f49] 335290:41:06.561 DBG: [CID=0x0f49] Finding transaction for SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.561 DBG: [CID=0x0f49] Setting Transaction ID to NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER 335290:41:06.561 DTL: [CID=0x0f49] Found NICT|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER for SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.561 DTL: [CID=0x0f49] NICT(160656375) Event(SIPMessage) - SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.561 DBG: [CID=0x0f49] TRANSACTION: (NICT) SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing State: 1 335290:41:06.561 DTL: [CID=0x0f49] NICT(160656375) StateTrying->StateCompleted 335290:41:06.561 DBG: [CID=0x0f49] NICT(160656375) Timer E STOPPED 335290:41:06.561 DBG: [CID=0x0f49] NICT(160656375) Timer F STOPPED 335290:41:06.561 DBG: [CID=0x0f49] Event: SIPStack::Enqueue(SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing) 335290:41:06.562 DBG: [CID=0x0f49] NICT(160656375) Timer K( 5000 ms ) STARTED 335290:41:06.562 DBG: [CID=0x0f49] Event: B2BUserAgent::ProcessEvent( SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing ) 335290:41:06.562 DBG: [CID=0x0f49] Event: Setting UA Core [Proxy] to handle event REGISTER 335290:41:06.562 DTL: [CID=0x0f49] Event: ---> Inbound - SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.562 DBG: [CID=0x0f49] *** MESSAGE ARRIVAL *** for SIP Session NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.562 DBG: [CID=0x0f49] Finding transaction for SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.562 DBG: [CID=0x0f49] Setting Transaction ID to NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK-d87543-842bd60df3018b7b-1--d87543-|REGISTER 335290:41:06.562 DTL: [CID=0x0f49] Found NIST|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK-d87543-842bd60df3018b7b-1--d87543-|REGISTER for SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.563 DTL: [CID=0x0f49] NIST(160656374) Event(SIPMessage) - SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.563 DBG: [CID=0x0f49] TRANSACTION: (NIST) SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing State: 2 335290:41:06.563 DTL: [CID=0x0f49] NIST(160656374) StateProceeding->StateCompleted 335290:41:06.563 DBG: [CID=0x0f49] NIST(160656374) Timer J( 32000 ms ) STARTED 335290:41:06.563 INF: [CID=0x0f49] >>> SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing DST: 10.2.2.2:22326:UDP SRC: 10.1.1.1:5060 enc=0 bytes=657 335290:41:06.563 DBG: [CID=0x0f49] 335290:41:06.563 DBG: [CID=0x0f49] SIP/2.0 400 Bad Request - P-Visited-Network-ID header missing 335290:41:06.563 DBG: [CID=0x0f49] From: "Javi" <sip:javier@probe.test>;tag=fc6f8027 335290:41:06.563 DBG: [CID=0x0f49] To: "Javi" <sip:javier@probe.test>;tag=52d9d80fa1acefdf01b269454b0bf1a1-6137 335290:41:06.563 DBG: [CID=0x0f49] Via: SIP/2.0/UDP 10.2.2.2:22326;iid=18308;branch=z9hG4bK-d87543-842bd60df3018b7b-1--d87543-;rport=22326;received=10.2.2.2 335290:41:06.563 DBG: [CID=0x0f49] CSeq: 1 REGISTER 335290:41:06.563 DBG: [CID=0x0f49] Call-ID: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.563 DBG: [CID=0x0f49] Server: Sip EXpress router (2.1.0-dev1 OpenIMSCore (i386/linux)) 335290:41:06.563 DBG: [CID=0x0f49] Warning: 392 10.3.3.3:5060 "Noisy feedback tells: pid=19841 req_src_ip=10.1.1.1 req_src_port=5060 in_uri=sip:probe.test out_uri=sip:probe.test via_cnt==2" 335290:41:06.563 DBG: [CID=0x0f49] Content-Length: 0 335290:41:06.563 DBG: [CID=0x0f49] 335290:41:06.563 DBG: [CID=0x0f49] 335290:41:06.563 PWL: [CID=0x0000] Using Iface: 10.1.1.1 to send to Dest: 10.2.2.2 335290:41:06.563 DTL: [CID=0x06cb] *** QUEUED FOR DELETION *** SIPSession: NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:06.563 DBG: [CID=0x0000] GC: First Stale Object ProxySession 335290:41:07.564 INF: [CID=0x0f49] *** DESTROYED *** PROXY Session NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU. 335290:41:07.564 DBG: [CID=0x0f49] PROXY: Session DESTROYED 335290:41:11.559 DBG: [CID=0x0f49] NICT(160656375) Timer K( 5000 ms ) EXPIRED 335290:41:11.559 DTL: [CID=0x0f49] NICT(160656375) Event( Timer-K ) Interval: 5000 335290:41:11.559 DTL: [CID=0x0f49] NICT(160656375) Event(Final) 335290:41:11.559 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NICT|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER 335290:41:11.559 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction 335290:41:11.559 DBG: [CID=0x0f49] TRANSACTION: (NICT) DESTROYED 335290:41:11.559 DTL: [CID=0x0f49] NICT(160656375) *** DESTROYED *** - NICT|NzliNWNlNTZiMWZmMGZiMWI5ZTFmYzQ1MTZlYzkxZTU.|z9hG4bK9e3258cd45fedc118f2fb33a52202fcf-9fdd45cf333b38ed3bc3c80432dad79c|REGISTER |