[IMPALA-6602] TestQueryExpiration.test_query_expiration fails on Isilon with FINISHED rather than EXCEPTION state

• Type: Bug
• Status: Resolved
• Priority: Blocker
• Resolution: Fixed
• Affects Version/s: Impala 2.12.0
• Fix Version/s: Impala 3.0, Impala 2.12.0
• Component/s: Backend
• Labels: broken-build
• Target Version: Impala 2.12.0
• Epic Color: ghx-label-7
• Assignee: Vuk Ercegovac
• Reporter: Lars Volker
• Created: 03/Mar/18 22:52
• Updated: 12/Mar/18 21:39
• Resolved: 08/Mar/18 16:47

Description

TestQueryExpiration.test_query_expiration failed on Isilon. It looks like an additional query expired while the test was running. It is marked as execute_serially though.

Here is the relevant part of the log:

23:20:15 =========================== short test summary info ============================
23:20:15 XFAIL custom_cluster/test_alloc_fail.py::TestAllocFail::()::test_alloc_fail_update[exec_option: {'batch_size': 0, 'num_nodes': 0, 'disable_codegen_rows_threshold': 0, 'disable_codegen': False, 'abort_on_error': 1, 'debug_action': None, 'exec_single_node_rows_threshold': 0} | table_format: text/none]
23:20:15   IMPALA-2925: the execution is not deterministic so some tests sometimes don't fail as expected
23:20:15 FAIL custom_cluster/test_query_expiration.py::TestQueryExpiration::()::test_query_expiration[exec_option: {'batch_size': 0, 'num_nodes': 0, 'disable_codegen_rows_threshold': 0, 'disable_codegen': False, 'abort_on_error': 1, 'debug_action': None, 'exec_single_node_rows_threshold': 0} | table_format: text/none]
23:20:15 =================================== FAILURES ===================================
23:20:15  TestQueryExpiration.test_query_expiration[exec_option: {'batch_size': 0, 'num_nodes': 0, 'disable_codegen_rows_threshold': 0, 'disable_codegen': False, 'abort_on_error': 1, 'debug_action': None, 'exec_single_node_rows_threshold': 0} | table_format: text/none] 
23:20:15 custom_cluster/test_query_expiration.py:104: in test_query_expiration
23:20:15     assert (client.get_state(default_timeout_expire_handle2) ==
23:20:15 E   assert 4 == 5
23:20:15 E    +  where 4 = <bound method BeeswaxConnection.get_state of <tests.common.impala_connection.BeeswaxConnection object at 0x38e6390>>(<tests.common.impala_connection.OperationHandle object at 0x38e64d0>)
23:20:15 E    +    where <bound method BeeswaxConnection.get_state of <tests.common.impala_connection.BeeswaxConnection object at 0x38e6390>> = <tests.common.impala_connection.BeeswaxConnection object at 0x38e6390>.get_state

vukercegovac - I picked you randomly; feel free to find another person or assign back to me if you're swamped. I’ve seen this happen in a private Jenkins run. Please ping me if you would like access to the build artifacts.