[ https://issues.apache.org/jira/browse/IMPALA-13167?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Michael Smith resolved IMPALA-13167. ------------------------------------ Fix Version/s: Impala 4.5.0 Resolution: Fixed > Impala's coordinator could not be connected after a restart in custom cluster > test in the ASAN build on ARM > ----------------------------------------------------------------------------------------------------------- > > Key: IMPALA-13167 > URL: https://issues.apache.org/jira/browse/IMPALA-13167 > Project: IMPALA > Issue Type: Bug > Reporter: Fang-Yu Rao > Assignee: Fang-Yu Rao > Priority: Minor > Labels: broken-build > Fix For: Impala 4.5.0 > > > In an internal Jenkins run, we found that it's possible that Impala's > coordinator could not be connected after a restart that occurred after the > coordinator hit a DCHECK during the custom cluster test in the ASAN build on > ARM. > Specifically, in that Jenkins run, we found that Impala's coordinator hit the > DCHECK in [RuntimeProfile::EventSequence::Start(int64_t > start_time_ns)|https://github.com/apache/impala/blob/master/be/src/util/runtime-profile-counters.h#L656] > while running a query in > [ranger_column_masking_complex_types.test|https://github.com/apache/impala/blob/master/testdata/workloads/functional-query/queries/QueryTest/ranger_column_masking_complex_types.test#L724-L732] > that was run by > [test_column_masking()|https://github.com/apache/impala/blob/master/tests/authorization/test_ranger.py#L1916]. > This is a known issue as described in IMPALA-4631. > Since Impala daemons and the catalog server are restarted for each test in > test_ranger.py, the next test run after test_column_masking() should most > likely be passed. However it did not seem like this. We found that for the > following few tests (e.g., test_block_metadata_update()) in test_ranger.py, > Impala's pytest framework was not able to connect to the coordinator with the > following error and hence those tests failed. > {code:java} > -- 2024-06-18 08:49:43,350 INFO MainThread: Starting cluster with > command: > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/bin/start-impala-cluster.py > '--state_store_args=--statestore_update_frequency_ms=50 > --statestore_priority_update_frequency_ms=50 > --statestore_heartbeat_frequency_ms=50' --cluster_size=3 --num_coordinators=3 > --log_dir=/data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests > --log_level=1 '--impalad_args=--server-name=server1 > --ranger_service_type=hive --ranger_app_id=impala > --authorization_provider=ranger ' '--state_store_args=None ' > '--catalogd_args=--server-name=server1 --ranger_service_type=hive > --ranger_app_id=impala --authorization_provider=ranger ' > --impalad_args=--default_query_options= > 08:49:43 MainThread: Found 0 impalad/0 statestored/0 catalogd process(es) > 08:49:43 MainThread: Starting State Store logging to > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests/statestored.INFO > 08:49:43 MainThread: Starting Catalog Service logging to > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests/catalogd.INFO > 08:49:44 MainThread: Starting Impala Daemon logging to > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests/impalad.INFO > 08:49:44 MainThread: Starting Impala Daemon logging to > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests/impalad_node1.INFO > 08:49:44 MainThread: Starting Impala Daemon logging to > /data/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/logs/custom_cluster_tests/impalad_node2.INFO > 08:49:47 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:47 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:47 MainThread: Getting num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25000 > 08:49:47 MainThread: Debug webpage not yet available: > HTTPConnectionPool(host='impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com', > port=25000): Max retries exceeded with url: /backends?json (Caused by > NewConnectionError('<urllib3.connection.HTTPConnection object at > 0xffff8d176750>: Failed to establish a new connection: [Errno 111] Connection > refused',)) > 08:49:49 MainThread: Debug webpage did not become available in expected time. > 08:49:49 MainThread: Waiting for num_known_live_backends=3. Current value: > None > 08:49:50 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:50 MainThread: Getting num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25000 > 08:49:50 MainThread: Waiting for num_known_live_backends=3. Current value: 0 > 08:49:51 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:51 MainThread: Getting num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25000 > 08:49:51 MainThread: num_known_live_backends has reached value: 3 > 08:49:51 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:51 MainThread: Getting num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25001 > 08:49:51 MainThread: num_known_live_backends has reached value: 3 > 08:49:52 MainThread: Found 3 impalad/1 statestored/1 catalogd process(es) > 08:49:52 MainThread: Getting num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25002 > 08:49:52 MainThread: num_known_live_backends has reached value: 3 > 08:49:52 MainThread: Impala Cluster Running with 3 nodes (3 coordinators, 3 > executors). > -- 2024-06-18 08:49:52,811 DEBUG MainThread: Found 3 impalad/1 > statestored/1 catalogd process(es) > -- 2024-06-18 08:49:52,811 INFO MainThread: Getting metric: > statestore.live-backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25010 > -- 2024-06-18 08:49:52,814 INFO MainThread: Metric > 'statestore.live-backends' has reached desired value: 4 > -- 2024-06-18 08:49:52,814 DEBUG MainThread: Getting > num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25000 > -- 2024-06-18 08:49:52,816 INFO MainThread: num_known_live_backends has > reached value: 3 > -- 2024-06-18 08:49:52,816 DEBUG MainThread: Getting > num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25001 > -- 2024-06-18 08:49:52,818 INFO MainThread: num_known_live_backends has > reached value: 3 > -- 2024-06-18 08:49:52,818 DEBUG MainThread: Getting > num_known_live_backends from > impala-ec2-rhel88-m7g-4xlarge-ondemand-1d18.vpc.cloudera.com:25002 > -- 2024-06-18 08:49:52,820 INFO MainThread: num_known_live_backends has > reached value: 3 > SET > client_identifier=authorization/test_ranger.py::TestRanger::()::test_block_metadata_update[protocol:beeswax|exec_option:{'test_replan':1;'batch_size':0;'num_nodes':0;'disable_codegen_rows_threshold':0;'disable_codegen':False;'abort_on_error':1;'exec_single_node_rows_thresh; > -- connecting to: localhost:21000 > -- 2024-06-18 08:49:52,821 INFO MainThread: Could not connect to ('::1', > 21000, 0, 0) > Traceback (most recent call last): > File > "/data0/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/infra/python/env-gcc10.4.0/lib/python2.7/site-packages/thrift/transport/TSocket.py", > line 137, in open > handle.connect(sockaddr) > File > "/data/jenkins/workspace/impala-asf-master-core-asan-arm/Impala-Toolchain/toolchain-packages-gcc10.4.0/python-2.7.16/lib/python2.7/socket.py", > line 228, in meth > return getattr(self._sock,name)(*args) > error: [Errno 111] Connection refused > -- connecting to localhost:21050 with impyla > -- 2024-06-18 08:49:52,821 INFO MainThread: Could not connect to ('::1', > 21050, 0, 0) > Traceback (most recent call last): > File > "/data0/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/infra/python/env-gcc10.4.0/lib/python2.7/site-packages/thrift/transport/TSocket.py", > line 137, in open > handle.connect(sockaddr) > File > "/data/jenkins/workspace/impala-asf-master-core-asan-arm/Impala-Toolchain/toolchain-packages-gcc10.4.0/python-2.7.16/lib/python2.7/socket.py", > line 228, in meth > return getattr(self._sock,name)(*args) > error: [Errno 111] Connection refused > -- 2024-06-18 08:49:53,036 INFO MainThread: Closing active operation > -- connecting to localhost:28000 with impyla > -- 2024-06-18 08:49:53,058 INFO MainThread: Closing active operation > SET > client_identifier=authorization/test_ranger.py::TestRanger::()::test_block_metadata_update[protocol:beeswax|exec_option:{'test_replan':1;'batch_size':0;'num_nodes':0;'disable_codegen_rows_threshold':0;'disable_codegen':False;'abort_on_error':1;'exec_single_node_rows_thresh; > -- connecting to: localhost:21000 > -- 2024-06-18 08:49:53,061 INFO MainThread: Could not connect to ('::1', > 21000, 0, 0) > Traceback (most recent call last): > File > "/data0/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/infra/python/env-gcc10.4.0/lib/python2.7/site-packages/thrift/transport/TSocket.py", > line 137, in open > handle.connect(sockaddr) > File > "/data/jenkins/workspace/impala-asf-master-core-asan-arm/Impala-Toolchain/toolchain-packages-gcc10.4.0/python-2.7.16/lib/python2.7/socket.py", > line 228, in meth > return getattr(self._sock,name)(*args) > error: [Errno 111] Connection refused > SET > client_identifier=authorization/test_ranger.py::TestRanger::()::test_block_metadata_update[protocol:beeswax|exec_option:{'test_replan':1;'batch_size':0;'num_nodes':0;'disable_codegen_rows_threshold':0;'disable_codegen':False;'abort_on_error':1;'exec_single_node_rows_thresh; > -- connecting to: localhost:21000 > -- 2024-06-18 08:49:53,062 INFO MainThread: Could not connect to ('::1', > 21000, 0, 0) > Traceback (most recent call last): > File > "/data0/jenkins/workspace/impala-asf-master-core-asan-arm/repos/Impala/infra/python/env-gcc10.4.0/lib/python2.7/site-packages/thrift/transport/TSocket.py", > line 137, in open > handle.connect(sockaddr) > File > "/data/jenkins/workspace/impala-asf-master-core-asan-arm/Impala-Toolchain/toolchain-packages-gcc10.4.0/python-2.7.16/lib/python2.7/socket.py", > line 228, in meth > return getattr(self._sock,name)(*args) > error: [Errno 111] Connection refused > {code} -- This message was sent by Atlassian Jira (v8.20.10#820010)