On 05/07/2019 9:26 am, Oleksandr Rudyy wrote:
Hi Gordon,

Thanks for testing the release and reporting a test failure.

The failed test sends open performative against non existing virtual host
and expects to receive an "open" back containing an error "amqp:not-found"
within 6 seconds after sending "open".
The failure occurred because "open" was not received within 6 seconds. It
could be environmental. For example, a long GC "stop the world" pause can
cause it, or, environment in use could be slow.

I did run all the tests a second time and again it failed on that specific test only. (Not that that necessarily rules out your hypothesis)

The test logs could provide more details about test execution.

If you still have a test log file
./systests/protocol-tests-amqp-1-0/target/surefire-reports/java-mms.1-0/TEST-org.apache.qpid.tests.protocol.v1_0.transport.connection.OpenTest.failOpenOnNonExistingHostname.txt,
could you please send it over?

Attached
2019-07-04 17:45:02,459 INFO  [main] o.a.q.t.u.EmbeddedBrokerPerClassAdminImpl 
========================= start executing test : 
OpenTest#failOpenOnNonExistingHostname
2019-07-04 17:45:02,464 DEBUG [IO-pool-Port-ANONYMOUS_AMQP-7] 
o.a.q.s.t.NonBlockingConnection Identified transport encryption as NONE
2019-07-04 17:45:02,465 DEBUG [IO-/127.0.0.1:58352] 
o.a.q.s.t.NonBlockingConnection Read 8 byte(s)
2019-07-04 17:45:02,465 DEBUG [Broker-Config] o.a.q.s.c.u.TaskExecutorImpl 
Performing Task['create' on '/127.0.0.1:58352(?)']
2019-07-04 17:45:02,466 INFO  [Broker-Config] q.m.c.open 
[con:18(/127.0.0.1:58352)] CON-1001 : Open : Destination : 
ANONYMOUS_AMQP(127.0.0.1:37791) : Protocol Version : 1.0
2019-07-04 17:45:02,466 DEBUG [Broker-Config] o.a.q.s.c.u.TaskExecutorImpl 
Task['create' on '/127.0.0.1:58352(?)'] performed successfully with result: null
2019-07-04 17:45:02,466 DEBUG [IO-/127.0.0.1:58352] o.a.q.s.p.v.f.FrameHandler 
RECV 0 bytes
2019-07-04 17:45:02,466 DEBUG [IO-/127.0.0.1:58352] 
o.a.q.s.t.NonBlockingConnection Written 8 bytes
2019-07-04 17:45:02,466 DEBUG [IO-/127.0.0.1:58352] 
o.a.q.s.t.NonBlockingConnection Read 0 byte(s)
2019-07-04 17:45:02,466 DEBUG [nioEventLoopGroup-20-1] o.a.q.t.p.InputHandler 
Incoming 8 byte(s)
2019-07-04 17:45:02,466 DEBUG [nioEventLoopGroup-20-1] 
o.a.q.s.p.v.f.FrameHandler RECV 0 bytes
2019-07-04 17:45:02,466 DEBUG [nioEventLoopGroup-20-1] o.a.q.t.p.InputHandler 
After parsing, 0 byte(s) remained
2019-07-04 17:45:02,467 DEBUG [IO-/127.0.0.1:58352] 
o.a.q.s.t.NonBlockingConnection Read 72 byte(s)
2019-07-04 17:45:02,467 DEBUG [IO-/127.0.0.1:58352] o.a.q.s.p.v.f.FrameHandler 
RECV 72 bytes
2019-07-04 17:45:02,467 DEBUG [IO-/127.0.0.1:58352] o.a.q.s.p.frame 
RECV[/127.0.0.1:58352|0] : 
Open{containerId=testContainerId,hostname=non-existing-virtual-host-1562258702466}
2019-07-04 17:45:08,468 DEBUG [nioEventLoopGroup-20-1] i.n.b.PoolThreadCache 
Freed 2 thread-local buffer(s) from thread: nioEventLoopGroup-20-1
2019-07-04 17:45:08,476 INFO  [main] o.a.q.t.u.EmbeddedBrokerPerClassAdminImpl 
========================= stop executing test : 
OpenTest#failOpenOnNonExistingHostname
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to