Hi, I'm new to pjsip. During heavy load (30 concurrent call), pjsip 1.5.5 seems can't handle transaction retransmit timer event correctly. 06:00:46.981 dlg0x8614abc Transaction tsx0x89595dc state changed to Terminated 06:00:46.981 tsx0x866c444 Timeout timer event 06:00:46.981 tsx0x866c444 State changed from Terminated to Destroyed, event=TIMER 06:00:46.981 tdta0x866e738 Destroying txdata Response msg 200/INVITE/cseq=25493 (tdta0x866e738) 06:00:46.981 tsx0x866c444 Transaction destroyed! 06:00:46.981 tsx0x866c444 tsx_on_state_terminated for INVITE transaction , 1 866c444 06:00:46.981 tsx0x86babcc Timeout timer event 06:00:46.981 tsx0x86babcc State changed from Terminated to Destroyed, event=TIMER 06:00:46.981 tdta0x86bcbb0 Destroying txdata Response msg 200/INVITE/cseq=29539 (tdta0x86bcbb0) 06:00:46.981 tsx0x86babcc Transaction destroyed! 06:00:46.981 tsx0x86babcc tsx_on_state_terminated for INVITE transaction , 1 86babcc 06:00:46.981 tsx0x873f354 Timeout timer event 06:00:46.981 tsx0x873f354 State changed from Terminated to Destroyed, event=TIMER 06:00:46.981 tdta0x8741648 Destroying txdata Response msg 200/INVITE/cseq=22480 (tdta0x8741648) 06:00:46.981 tsx0x873f354 Transaction destroyed! 06:00:46.981 tsx0x873f354 tsx_on_state_terminated for INVITE transaction , 1 873f354 06:00:47.041 tsx0x89595dc Timeout timer event 06:00:47.041 tsx0x89595dc State changed from Terminated to Destroyed, event=TIMER 06:00:47.041 tdta0x895b8d0 Destroying txdata Response msg 200/INVITE/cseq=24474 (tdta0x895b8d0) 06:00:47.041 tsx0x89595dc Transaction destroyed! 06:00:47.041 tsx0x89595dc tsx_on_state_terminated for INVITE transaction , 1 89595dc 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1383 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 401 bytes Request msg ACK/cseq=1383 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bK21d2.31900f16.2 Via: SIP/2.0/UDP 66.151.96.244:6053;received=66.151.96.244;rport=6053;branch=z9hG4bKPj22f344cf-6e9f-4c3b-b Max-Forwards: 69 From: <sip:66.151.96.244>;tag=45d4afcf-8d14-4d42-b To: sip:000 at 66.151.96.245;tag=f6a0515f-b440-46c8-8 Call-ID: 9bd13d14-3ce4-400f-9 CSeq: 1383 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x8958a3c Received Request msg ACK/cseq=1383 (rdata0x82ce24c) 06:00:47.041 tsx0x89783b4 Request to terminate transaction 06:00:47.041 tsx0x89783b4 State changed from Completed to Terminated, event=USER 06:00:47.041 dlg0x8958a3c Transaction tsx0x89783b4 state changed to Terminated 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=13302 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 402 bytes Request msg ACK/cseq=13302 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bKb83a.92be9824.2 Via: SIP/2.0/UDP 66.151.96.244:6040;received=66.151.96.244;rport=6040;branch=z9hG4bKPj945818a0-76e5-492e-a Max-Forwards: 69 From: <sip:66.151.96.244>;tag=93577a60-6b0d-446f-a To: sip:000 at 66.151.96.245;tag=e9596889-54ed-4d28-a Call-ID: da48bb97-f24c-4758-a CSeq: 13302 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x880de64 Received Request msg ACK/cseq=13302 (rdata0x82ce24c) 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1974 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 401 bytes Request msg ACK/cseq=1974 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bKbf6e.3275a8f3.2 Via: SIP/2.0/UDP 66.151.96.244:6039;received=66.151.96.244;rport=6039;branch=z9hG4bKPj0648b2e4-2709-4869-9 Max-Forwards: 69 From: <sip:66.151.96.244>;tag=9933db93-5fd2-441d-b To: sip:000 at 66.151.96.245;tag=c2459cab-e1fa-40dc-b Call-ID: 90967e2e-8513-4409-8 CSeq: 1974 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x8835fbc Received Request msg ACK/cseq=1974 (rdata0x82ce24c) 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=11558 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 402 bytes Request msg ACK/cseq=11558 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bKe75f.a342b143.2 Via: SIP/2.0/UDP 66.151.96.244:6036;received=66.151.96.244;rport=6036;branch=z9hG4bKPj2ee60f51-2970-4f80-a Max-Forwards: 69 From: <sip:66.151.96.244>;tag=0a3efbcb-66a1-4719-b To: sip:000 at 66.151.96.245;tag=1779c90e-b5ec-442c-b Call-ID: 9b19b981-bdb4-43e0-b CSeq: 11558 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x8886524 Received Request msg ACK/cseq=11558 (rdata0x82ce24c) 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=27835 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 400 bytes Request msg ACK/cseq=27835 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bKa38.7e7224d.2 Via: SIP/2.0/UDP 66.151.96.244:6059;received=66.151.96.244;rport=6059;branch=z9hG4bKPj8fec8c51-986c-4002-b Max-Forwards: 69 From: <sip:66.151.96.244>;tag=876410c8-bcc3-4f96-8 To: sip:000 at 66.151.96.245;tag=e59ab129-3fed-49cd-9 Call-ID: ef2dd728-2a3c-472d-9 CSeq: 27835 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x8977814 Received Request msg ACK/cseq=27835 (rdata0x82ce24c) 06:00:47.041 tsx0x89971b4 Request to terminate transaction 06:00:47.041 tsx0x89971b4 State changed from Completed to Terminated, event=USER 06:00:47.041 dlg0x8977814 Transaction tsx0x89971b4 state changed to Terminated 06:00:47.041 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=5585 (rdata0x82ce24c) 06:00:47.041 pjsua_core.c RX 401 bytes Request msg ACK/cseq=5585 (rdata0x82ce24c) from UDP 66.151.96.245:5060: ACK sip:000 at 66.151.96.244:5060 SIP/2.0 Via: SIP/2.0/UDP 66.151.96.245;branch=z9hG4bK608a.f9eeaae5.2 Via: SIP/2.0/UDP 66.151.96.244:6037;received=66.151.96.244;rport=6037;branch=z9hG4bKPjaea70710-4ca6-4728-b Max-Forwards: 69 From: <sip:66.151.96.244>;tag=278ab022-48da-41a4-8 To: sip:000 at 66.151.96.245;tag=5d95adf6-8023-421d-b Call-ID: bd2b4cfe-ac87-42d4-9 CSeq: 5585 ACK Content-Length: 0 --end msg-- 06:00:47.041 dlg0x869928c Received Request msg ACK/cseq=5585 (rdata0x82ce24c) 06:00:47.053 strm0x8845a3c Starting silence 06:00:47.054 strm0x888cb14 Start talksprut.. 06:00:47.057 strm0x869f4ec JB shrinking 1 frame(s), cur size=24 06:00:47.057 strm0x85f5b54 JB shrinking 1 frame(s), cur size=24 06:00:46.983 tsx0x8780ff4 Timeout timer event 06:00:47.058 tsx0x8780ff4 State changed from Terminated to Destroyed, event=TIMER 06:00:47.058 tdta0x87831e0 Destroying txdata Response msg 200/INVITE/cseq=15623 (tdta0x87831e0) 06:00:47.058 tsx0x8780ff4 Transaction destroyed! 06:00:47.058 tsx0x8780ff4 tsx_on_state_terminated for INVITE transaction , 1 8780ff4 06:00:46.983 tsx0x878065c Timeout timer event 06:00:47.060 tsx0x878065c State changed from Terminated to Destroyed, event=TIMER 06:00:47.060 tdta0x893cb48 Destroying txdata Response msg 200/INVITE/cseq=29469 (tdta0x893cb48) 06:00:47.060 tsx0x878065c Transaction destroyed! 06:00:47.060 tsx0x878065c tsx_on_state_terminated for INVITE transaction , 1 878065c 06:00:46.923 tsx0x89595dc Retransmit timer event 06:00:47.060 tsx0x89595dc tsx_on_state_destroyed for INVITE transaction , 1 89595dc iGWAdapter: ../src/pjsip/sip_transaction.c:3073: tsx_on_state_destroyed: Assertion `!"Not expecting any events!!"' failed. Aborted (core dumped) Thanks John -------------- next part -------------- An HTML attachment was scrubbed... URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20100427/355acbe0/attachment-0001.html>
