search

phyhw / doubango

Automatically exported from code.google.com/p/doubango
0 stars 0 forks source link

doubango fsm failed after call frequently #82

Open GoogleCodeExporter opened 9 years ago

GoogleCodeExporter commented 9 years ago 
What steps will reproduce the problem?
1. two imsdroid call , the caller call callee  frequently, call->accept->hangup.
   after many times , the caller freeze there,the log show fsm failed.
2.
  after call many times , then the new call , the transaction fsm is init and put  to ict list , but when we begine to execute the fist ict callback, it failed ,
 from the log below ,i see that the list of ict fsm has bad data.
3.

What is the expected output? What do you see instead?

log:

I/tinyWRAP( 1037): [Jan  1 20:09:45] NOTICE[1037]: src/trtp_manager.c:203 
trtp_manager_prepare: 
I/tinyWRAP( 1037): RTP/RTCP manager[End]: Trying to bind to random ports
I/tinyWRAP( 1037): video session from codecs to sdp
I/tinyWRAP( 1037): ####tdav_codec_h264_fmtp_get: fmtp: profile-level-id=42801f
I/tinyWRAP( 1037): fmtp profile-level-id=42801f; packetization-mode=1; 
max-br=452; max-mbps=11880
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: 
src/dialogs/tsip_dialog_invite.c:907 send_INVITEorUPDATE: 
I/tinyWRAP( 1037): send out request
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: 
src/transactions/tsip_transac_ict.c:875 tsip_transac_ict_ctor: 
I/tinyWRAP( 1037): init base _ict transiction
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: 
src/transactions/tsip_transac.c:70 tsip_transac_init: 
I/tinyWRAP( 1037): === create a transaction fsm, type is   ict
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: 
src/transactions/tsip_transac_ict.c:239 tsip_transac_ict_init: 
I/tinyWRAP( 1037): init ict transaction
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 255 from = 0 to = 1 function  = 
tsip_transac_ict_Started_2_Calling_X_send 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = -65535 from = 0 to = 0 function  = 
tsip_transac_ict_Started_2_Started_X_any 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 256 from = 1 to = 1 function  = 
tsip_transac_ict_Calling_2_Calling_X_timerA 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 257 from = 1 to = 5 function  = 
tsip_transac_ict_Calling_2_Terminated_X_timerB 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 262 from = 1 to = 3 function  = 
tsip_transac_ict_Calling_2_Completed_X_300_to_699 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 260 from = 1 to = 2 function  = 
tsip_transac_ict_Calling_2_Proceeding_X_1xx 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 261 from = 1 to = 4 function  = 
tsip_transac_ict_Calling_2_Accepted_X_2xx 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 260 from = 2 to = 2 function  = 
tsip_transac_ict_Proceeding_2_Proceeding_X_1xx 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 262 from = 2 to = 3 function  = 
tsip_transac_ict_Proceeding_2_Completed_X_300_to_699 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 261 from = 2 to = 4 function  = 
tsip_transac_ict_Proceeding_2_Accepted_X_2xx 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 262 from = 3 to = 3 function  = 
tsip_transac_ict_Completed_2_Completed_X_300_to_699 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 258 from = 3 to = 5 function  = 
tsip_transac_ict_Completed_2_Terminated_X_timerD 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 261 from = 4 to = 4 function  = 
tsip_transac_ict_Accepted_2_Accepted_X_2xx 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 259 from = 4 to = 5 function  = 
tsip_transac_ict_Accepted_2_Terminated_X_timerM 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 263 from = -65535 to = 5 function  = 
tsip_transac_ict_Any_2_Terminated_X_transportError 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 264 from = -65535 to = 5 function  = 
tsip_transac_ict_Any_2_Terminated_X_Error 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:82 tsk_fsm_set: 
I/tinyWRAP( 1037): create one fsm entry 
I/tinyWRAP( 1037): action = 13 from = -65535 to = 5 function  = 
tsip_transac_ict_Any_2_Terminated_X_cancel 
I/tinyWRAP( 1037): 
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/dialogs/tsip_dialog.c:424 
tsip_dialog_request_send: 
I/tinyWRAP( 1037): create out outgoing request transaction
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: 
src/transactions/tsip_transac_ict.c:350 tsip_transac_ict_start: 
I/tinyWRAP( 1037): start client invite transaction
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:141 
tsk_fsm_act: 
I/tinyWRAP( 1037):     self action 255 self->current 0 self->term 5
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=0  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=0  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=1  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=1  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=1  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=1  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=1  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=2  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=2  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=2  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=3  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=3  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=4  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=4  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=-65535  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=-65535  to =1 fucntion= @)q�
I/tinyWRAP( 1037): [Jan  1 20:09:45] DEBUG[1037]: src/tsk_fsm.c:148 
tsk_fsm_act: 
I/tinyWRAP( 1037): fsm entry->action=27  from=-65535  to =1 fucntion= (null)
I/tinyWRAP( 1037): [Jan  1 20:09:45] ERROR[1037]: src/tsk_fsm.c:195 
tsk_fsm_act: 
I/tinyWRAP( 1037): State machine: Exec function failed. Moving to terminal 
state.
D/org.doubango.ngn.services.impl.NgnSipService( 1037): OnDialogEvent 
===================
D/org.doubango.ngn.services.impl.NgnSipService( 1037): OnDialogEvent (Dialog 
connecting,6; 900)
D/org.doubango.ngn.services.impl.NgnSipService( 1037): 
broadcastInviteEvent222222222222 =============

What version of the product are you using? On what operating system?

Please provide any additional information below.

Original issue reported on code.google.com by openser@yeah.net on 14 Nov 2011 at 5:50

GoogleCodeExporter commented 9 years ago

Original comment by boss...@yahoo.fr on 23 Nov 2011 at 11:48