[ 
https://issues.apache.org/jira/browse/DISPATCH-1772?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17200379#comment-17200379
 ] 

Charles E. Rolke commented on DISPATCH-1772:
--------------------------------------------

Adding some logging to the SwitchoverMix test and running it enough times leads 
to this instance of failure;

Time of day is just in seconds.
 Test 35. Sender: INT.A, Primary receiver: INT.B, Fallback receiver: EA1
 Test agent is named "peer_5".
{code:java}
Time(S)  What
-------  ----
00.3450  sender link open
00.3470  rx link open
00.3480  rx link open

         --- sender sends, all messages accepted

00.7241  B0_11 all accepted, detach (closes one minute later after TMO)

         --- release storm as A sends to B ---

01.2191  A -> B add MFdest.35   (this seem way late)
01.2522  B <- A add MFdest.35
01.3446  B -> A del M0dest.35
01.3473  A <- B del M0 dest.35
01.4448  A -> peer_5 FLOW with drain

         peer_5 sends 95 messages that consumes all the available credit
         peer_5 never sends a FLOW with drain set.
 {code}
There are a couple of odd things in the logs.

1. By the time that A notifies B of the fallback destination mobile address, 
the sender has already sent all of the Phase 0 messages. 
 2. The drain cycle is satisfied by having the sender send the full amount of 
credit's worth of transfers. Peer_5 never sends a FLOW with drain set back to 
INT.A.

> Fallback destination test prints insufficient data when it fails
> ----------------------------------------------------------------
>
>                 Key: DISPATCH-1772
>                 URL: https://issues.apache.org/jira/browse/DISPATCH-1772
>             Project: Qpid Dispatch
>          Issue Type: Bug
>          Components: Tests
>    Affects Versions: 1.13.0
>            Reporter: Charles E. Rolke
>            Assignee: Charles E. Rolke
>            Priority: Major
>
> Occasionally the Switchover_mix test fails in CI. When this happens then the 
> self test prints only a single line describing the failure such as:
> {code:java}
>         "63: 
> ======================================================================", 
>         "63: FAIL: test_35_switchover_mix_1 
> (system_tests_fallback_dest.RouterTest)", 
>         "63: 
> ----------------------------------------------------------------------", 
>         "63: Traceback (most recent call last):", 
>         "63:   File 
> \"/opt/qpid-dispatch-src/tests/system_tests_fallback_dest.py\", line 353, in 
> test_35_switchover_mix_1", 
>         "63:     self.assertEqual(None, test.error)", 
>         "63: AssertionError: None != u'Timeout Expired - n_tx=0, n_rx=0, 
> n_rel=1046, phase=1, local_rel=0'", 
>         "63: ", 
>         "63: 
> ----------------------------------------------------------------------", 
> {code}
> This error message says that (phase=1) all the messages were sent 
> successfully before the switchover was initiated. Then 1046 messages were 
> released by the locally connected router until the test timed out.
> Class system_test/Logger could be used to generate a much more detailed 
> narrative describing how the client test event stream played out. Further, 
> the Logger log marks the client events with microsecond resolution so that 
> when possible the log can be correlated with qdrouterd logs.



--
This message was sent by Atlassian Jira
(v8.3.4#803005)

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to