JUnit version 4.13.2
.08:20:21.305 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1786522821295
08:20:21.335 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
08:20:21.406 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
08:20:21.416 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task3Irz5W/test-tmp
08:20:21.421 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
08:20:21.424 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task3Irz5W/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
08:20:21.651 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

08:20:21.801 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:20:21.803 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

08:20:21.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:21.806788  9079 mini_oidc.cc:150] Starting JWKS server
08:20:21.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:21.810778  9079 webserver.cc:533] Webserver started at http://127.0.0.1:46755/ using document root <none> and password file <none>
08:20:21.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:21.811385  9079 mini_oidc.cc:186] Starting OIDC Discovery server
08:20:21.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:21.813282  9079 webserver.cc:533] Webserver started at http://127.0.0.1:34571/ using document root <none> and password file <none>
08:20:21.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T08:20:21Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
08:20:21.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T08:20:21Z Disabled control of system clock
08:20:21.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:21.873903  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:21.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:21.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal
08:20:21.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data
08:20:21.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:21.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:21.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:21.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:21.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:21.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:21.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/logs
08:20:21.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data/info.pb
08:20:21.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:21.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:21.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:21.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:21.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:21.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:21.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:21.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:21.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:20:21.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:21.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:21.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:21.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.254:43959
08:20:21.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.254
08:20:21.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:21.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:21.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:21.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:21.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:21.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:21.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:21.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:21.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json with env {}
08:20:22.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.172444  9105 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:22.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.173148  9105 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:22.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.173960  9105 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:22.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.206758  9105 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:20:22.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.207122  9105 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.207448  9105 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:20:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.207787  9105 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:20:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.208127  9105 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:20:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.208407  9105 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46755/jwks.json
08:20:22.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:22.245602  9105 master_runner.cc:387] Master server non-default flags:
08:20:22.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/logs
08:20:22.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:22.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:22.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:22.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:22.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data
08:20:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal
08:20:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:22.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:22.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:22.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:22.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.254:43959
08:20:22.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:22.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:22.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:22.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json
08:20:22.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:22.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:22.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data/info.pb
08:20:22.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.254
08:20:22.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:22.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:22.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:22.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:20:22.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:22.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:22.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:22.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:22.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:22.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:22.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:22.247493  9105 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:22.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:22.249969  9105 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:22.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.263525  9113 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:23.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:22.264138  9115 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:23.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.391822  9105 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.129s	user 0.425s	sys 0.699s
08:20:23.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.392213  9105 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.129s	user 0.425s	sys 0.699s
08:20:23.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.394963  9117 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:23.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.397760  9116 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1132 milliseconds
08:20:23.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.397799  9105 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
08:20:23.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.399335  9105 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:23.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.402096  9105 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:23.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.403491  9105 hybrid_clock.cc:648] HybridClock initialized: now 1786522823403481 us; error 103 us; skew 500 ppm
08:20:23.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.404472  9105 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:23.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.411857  9105 webserver.cc:533] Webserver started at http://127.8.221.254:37821/ using document root <none> and password file <none>
08:20:23.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.412973  9105 fs_manager.cc:362] Metadata directory not provided
08:20:23.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.413208  9105 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:23.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.413829  9105 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:23.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.418468  9105 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data/instance:
08:20:23.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf54b267f9c644cbbb3f486a57d94999"
08:20:23.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:23 on dist-test-slave-4tdj"
08:20:23.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.420015  9105 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal/instance:
08:20:23.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf54b267f9c644cbbb3f486a57d94999"
08:20:23.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:23 on dist-test-slave-4tdj"
08:20:23.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.429133  9105 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.003s
08:20:23.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.435707  9133 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:23.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.437088  9105 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.002s
08:20:23.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.437462  9105 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal
08:20:23.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf54b267f9c644cbbb3f486a57d94999"
08:20:23.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:23 on dist-test-slave-4tdj"
08:20:23.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.438722  9105 fs_report.cc:389] FS layout report
08:20:23.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:23.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal
08:20:23.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal
08:20:23.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data/data
08:20:23.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:23.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:23.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:23.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:23.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:23.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:23.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:23.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:23.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:23.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:23.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:23.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.514421  9105 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:23.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.516167  9105 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:23.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.516685  9105 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:23.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.587566  9105 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.254:43959
08:20:23.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.587651  9222 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.254:43959 every 8 connection(s)
08:20:23.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.590842  9105 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/data/info.pb
08:20:23.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.596690  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 9105
08:20:23.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.597234  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-0/wal/instance
08:20:23.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.597568  9223 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:23.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.602247  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/logs
08:20:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data/info.pb
08:20:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:23.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:23.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:20:23.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:23.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:23.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:23.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.253:44091
08:20:23.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.253
08:20:23.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:23.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:23.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:23.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json with env {}
08:20:23.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.612491  9223 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } has no permanent_uuid. Determining permanent_uuid...
08:20:23.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.637408  9223 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } has no permanent_uuid. Determining permanent_uuid...
08:20:23.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.639875  9136 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:23.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.643895  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:23.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.693348  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 1
08:20:23.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.698052  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:23.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.766530  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 2
08:20:23.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.770885  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:23.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.862385  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 3
08:20:23.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.866691  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:23.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.915717  9228 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:23.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.916316  9228 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:23.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.917050  9228 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:23.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.959455  9228 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:20:23.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.959762  9228 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:23.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.959962  9228 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:20:23.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.960152  9228 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:20:23.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.960388  9228 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:20:23.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:23.960543  9228 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46755/jwks.json
08:20:23.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.996959  9228 master_runner.cc:387] Master server non-default flags:
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/logs
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal
08:20:23.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.253:44091
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:23.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json
08:20:24.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:24.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:24.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data/info.pb
08:20:24.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.253
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:24.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:24.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:24.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:24.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:24.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.998325  9228 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:24.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:23.999970  9228 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:24.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:24.010180  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 4
08:20:24.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.013832  9242 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:24.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.017189  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:24.316660  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 5
08:20:24.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.321291  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:24.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:24.868820  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 6
08:20:24.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.876356  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.253:44091: Network error: Client connection negotiation failed: client connection to 127.8.221.253:44091: connect: Connection refused (error 111)
08:20:25.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.017710  9243 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:25.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:24.020284  9245 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:25.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:24.019754  9228 server_base.cc:1061] running on GCE node
08:20:25.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.130770  9228 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:25.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.134091  9228 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:25.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.136072  9228 hybrid_clock.cc:648] HybridClock initialized: now 1786522825136026 us; error 47 us; skew 500 ppm
08:20:25.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.137209  9228 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.143716  9228 webserver.cc:533] Webserver started at http://127.8.221.253:45589/ using document root <none> and password file <none>
08:20:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.144640  9228 fs_manager.cc:362] Metadata directory not provided
08:20:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.144826  9228 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.145272  9228 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:25.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.153314  9228 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data/instance:
08:20:25.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7559d01e844642f596c7c910dd879dfd"
08:20:25.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:25 on dist-test-slave-4tdj"
08:20:25.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.154913  9228 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal/instance:
08:20:25.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7559d01e844642f596c7c910dd879dfd"
08:20:25.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:25 on dist-test-slave-4tdj"
08:20:25.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.162671  9228 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.003s	sys 0.004s
08:20:25.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.168519  9263 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:25.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.169624  9228 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
08:20:25.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.169973  9228 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal
08:20:25.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7559d01e844642f596c7c910dd879dfd"
08:20:25.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:25 on dist-test-slave-4tdj"
08:20:25.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.170421  9228 fs_report.cc:389] FS layout report
08:20:25.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:25.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal
08:20:25.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data/data
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:25.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:25.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:25.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.219306  9228 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.220940  9228 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.221428  9228 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:25.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.290457  9228 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.253:44091
08:20:25.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.290544  9355 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.253:44091 every 8 connection(s)
08:20:25.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.293401  9228 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/data/info.pb
08:20:25.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.297220  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 9228
08:20:25.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.297657  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-1/wal/instance
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.299855  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/logs
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data/info.pb
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:25.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:25.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.252:34571
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.252
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:25.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:25.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:25.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json with env {}
08:20:25.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.302484  9356 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:25.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.317443  9356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } has no permanent_uuid. Determining permanent_uuid...
08:20:25.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.343701  9356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } has no permanent_uuid. Determining permanent_uuid...
08:20:25.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.358527  9356 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } has no permanent_uuid. Determining permanent_uuid...
08:20:25.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.361066  9268 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.365231  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.414794  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 1
08:20:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.419449  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.487875  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 2
08:20:25.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.492300  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.583671  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 3
08:20:25.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.588565  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.611855  9359 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:25.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.612402  9359 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:25.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.612897  9359 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:25.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.645434  9359 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:20:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.645758  9359 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.645967  9359 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:20:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.646155  9359 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:20:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.646354  9359 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:20:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.646492  9359 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46755/jwks.json
08:20:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.682075  9359 master_runner.cc:387] Master server non-default flags:
08:20:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/logs
08:20:25.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:25.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.252:34571
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46755/jwks.json
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:25.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data/info.pb
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.252
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:25.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:25.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:25.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:20:25.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:25.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:25.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:25.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:25.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:25.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:25.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.683377  9359 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:25.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.685076  9359 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:25.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.695981  9382 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.732017  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 4
08:20:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.739646  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:25.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.936771  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } attempt: 7
08:20:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:25.983577  9223 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } has no permanent_uuid. Determining permanent_uuid...
08:20:25.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.995229  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.039160  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 5
08:20:26.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.047168  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.053776  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 1
08:20:26.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.062753  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.144276  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 2
08:20:26.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.152099  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.237677  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 3
08:20:26.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.245110  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.385635  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 4
08:20:26.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.393287  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.594672  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 6
08:20:26.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.625010  9356 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:26.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:26.676796  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 5
08:20:26.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:26.684286  9223 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.221.252:34571: Network error: Client connection negotiation failed: client connection to 127.8.221.252:34571: connect: Connection refused (error 111)
08:20:27.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:25.696667  9385 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:27.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.018582  9387 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:27.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.021412  9359 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.325s	user 0.475s	sys 0.845s
08:20:27.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.022146  9359 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.326s	user 0.477s	sys 0.847s
08:20:27.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.025774  9386 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1320 milliseconds
08:20:27.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.026671  9359 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
08:20:27.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.028209  9359 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:27.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.031373  9359 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:27.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.033077  9359 hybrid_clock.cc:648] HybridClock initialized: now 1786522827033029 us; error 40 us; skew 500 ppm
08:20:27.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.034157  9359 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:27.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.043061  9359 webserver.cc:533] Webserver started at http://127.8.221.252:33433/ using document root <none> and password file <none>
08:20:27.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.044312  9359 fs_manager.cc:362] Metadata directory not provided
08:20:27.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.044587  9359 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:27.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.045146  9359 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:27.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.051532  9359 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data/instance:
08:20:27.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ffc524f0ca0e48de971c967106034d68"
08:20:27.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:27 on dist-test-slave-4tdj"
08:20:27.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.053035  9359 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal/instance:
08:20:27.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ffc524f0ca0e48de971c967106034d68"
08:20:27.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:27 on dist-test-slave-4tdj"
08:20:27.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.062816  9359 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.010s	sys 0.002s
08:20:27.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.070340  9417 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:27.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.073076  9359 fs_manager.cc:730] Time spent opening block manager: real 0.006s	user 0.002s	sys 0.002s
08:20:27.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.073916  9359 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal
08:20:27.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ffc524f0ca0e48de971c967106034d68"
08:20:27.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:27 on dist-test-slave-4tdj"
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.074455  9359 fs_report.cc:389] FS layout report
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data/data
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:27.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:27.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:27.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.153358  9359 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:27.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.155401  9359 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:27.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.155979  9359 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:27.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.228586  9359 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.252:34571
08:20:27.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.228639  9512 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.252:34571 every 8 connection(s)
08:20:27.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.231655  9359 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/data/info.pb
08:20:27.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.232332  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 9359
08:20:27.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.232676  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/master-2/wal/instance
08:20:27.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.236765  9223 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 6
08:20:27.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.239614  9514 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:27.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.266963  9514 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } has no permanent_uuid. Determining permanent_uuid...
08:20:27.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.290159  9514 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } has no permanent_uuid. Determining permanent_uuid...
08:20:27.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.294723  9223 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: Bootstrap starting.
08:20:27.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.302997  9223 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: Neither blocks nor log segments found. Creating new log.
08:20:27.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.305838  9223 log.cc:826] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: Log is configured to *not* fsync() on all Append() calls
08:20:27.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.306623  9514 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } has no permanent_uuid. Determining permanent_uuid...
08:20:27.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.318481  9223 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: No bootstrap required, opened a new log
08:20:27.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.327762  9514 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: Bootstrap starting.
08:20:27.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.335841  9514 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: Neither blocks nor log segments found. Creating new log.
08:20:27.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.338346  9514 log.cc:826] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: Log is configured to *not* fsync() on all Append() calls
08:20:27.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.345593  9223 raft_consensus.cc:359] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.346930  9223 raft_consensus.cc:385] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:27.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.347204  9223 raft_consensus.cc:740] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: cf54b267f9c644cbbb3f486a57d94999, State: Initialized, Role: FOLLOWER
08:20:27.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.348004  9514 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: No bootstrap required, opened a new log
08:20:27.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.348119  9223 consensus_queue.cc:260] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.350849  9529 sys_catalog.cc:455] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.352078  9529 sys_catalog.cc:458] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.352779  9223 sys_catalog.cc:565] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: configured and running, proceeding with master startup.
08:20:27.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.373943  9514 raft_consensus.cc:359] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.374661  9514 raft_consensus.cc:385] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:27.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.374935  9514 raft_consensus.cc:740] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ffc524f0ca0e48de971c967106034d68, State: Initialized, Role: FOLLOWER
08:20:27.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.376395  9514 consensus_queue.cc:260] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.379299  9547 sys_catalog.cc:455] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.380431  9547 sys_catalog.cc:458] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.381798  9514 sys_catalog.cc:565] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: configured and running, proceeding with master startup.
08:20:27.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.399816  9546 catalog_manager.cc:1594] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:20:27.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.400764  9546 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:20:27.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.411999  9427 tablet.cc:2406] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:20:27.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.384917  9105 master_runner.cc:187] Error getting master registration for 127.8.221.253:44091: OK, instance_id { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" instance_seqno: 1786522825271993 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:20:27.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.415607  9105 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:20:27.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.437166  9570 catalog_manager.cc:1594] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:20:27.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.438124  9570 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:20:27.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.469574  9547 raft_consensus.cc:493] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:20:27.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.435709  9359 master_runner.cc:187] Error getting master registration for 127.8.221.253:44091: OK, instance_id { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" instance_seqno: 1786522825271993 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:20:27.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.470243  9547 raft_consensus.cc:515] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.473040  9547 leader_election.cc:290] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers cf54b267f9c644cbbb3f486a57d94999 (127.8.221.254:43959), 7559d01e844642f596c7c910dd879dfd (127.8.221.253:44091)
08:20:27.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.470248  9359 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:20:27.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.474802  9181 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ffc524f0ca0e48de971c967106034d68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cf54b267f9c644cbbb3f486a57d94999" is_pre_election: true
08:20:27.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.475742  9181 raft_consensus.cc:2468] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ffc524f0ca0e48de971c967106034d68 in term 0.
08:20:27.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.478909  9420 leader_election.cc:304] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: cf54b267f9c644cbbb3f486a57d94999, ffc524f0ca0e48de971c967106034d68; no voters: 
08:20:27.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.480731  9547 raft_consensus.cc:2804] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Leader pre-election won for term 1
08:20:27.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.481650  9547 raft_consensus.cc:493] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:20:27.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.482589  9547 raft_consensus.cc:3060] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 0 FOLLOWER]: Advancing to term 1
08:20:27.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.495437  9547 raft_consensus.cc:515] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.499600  9547 leader_election.cc:290] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [CANDIDATE]: Term 1 election: Requested vote from peers cf54b267f9c644cbbb3f486a57d94999 (127.8.221.254:43959), 7559d01e844642f596c7c910dd879dfd (127.8.221.253:44091)
08:20:27.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.505524  9181 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ffc524f0ca0e48de971c967106034d68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cf54b267f9c644cbbb3f486a57d94999"
08:20:27.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.506870  9181 raft_consensus.cc:3060] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 0 FOLLOWER]: Advancing to term 1
08:20:27.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.516206  9181 raft_consensus.cc:2468] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ffc524f0ca0e48de971c967106034d68 in term 1.
08:20:27.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.517894  9420 leader_election.cc:304] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: cf54b267f9c644cbbb3f486a57d94999, ffc524f0ca0e48de971c967106034d68; no voters: 
08:20:27.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.518781  9547 raft_consensus.cc:2804] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 1 FOLLOWER]: Leader election won for term 1
08:20:27.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.525317  9547 raft_consensus.cc:697] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [term 1 LEADER]: Becoming Leader. State: Replica: ffc524f0ca0e48de971c967106034d68, State: Running, Role: LEADER
08:20:27.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:27.526155  9145 tablet.cc:2406] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:20:27.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.526718  9547 consensus_queue.cc:237] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.544174  9573 sys_catalog.cc:455] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ffc524f0ca0e48de971c967106034d68. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.545774  9573 sys_catalog.cc:458] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: This master's current role is: LEADER
08:20:27.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.550782  9576 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
08:20:27.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.558588  9576 catalog_manager.cc:1520] Initializing Kudu cluster ID...
08:20:27.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.582633  9181 raft_consensus.cc:1275] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [term 1 FOLLOWER]: Refusing update from remote peer ffc524f0ca0e48de971c967106034d68: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:20:27.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.586313  9573 consensus_queue.cc:1048] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [LEADER]: Connected to new peer: Peer: permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:20:27.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.615700  9529 sys_catalog.cc:455] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ffc524f0ca0e48de971c967106034d68. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.619575  9529 sys_catalog.cc:458] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.625432  9583 mvcc.cc:204] Tried to move back new op lower bound from 7317597501757767680 to 7317597501559767040. Current Snapshot: MvccSnapshot[applied={T|T < 7317597501757767680}]
08:20:27.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.631623  9547 sys_catalog.cc:455] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.632369  9547 sys_catalog.cc:458] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: This master's current role is: LEADER
08:20:27.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.650485  9576 catalog_manager.cc:1383] Generated new cluster ID: 857eba963900490fbbb7ea7f5c688f28
08:20:27.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.650805  9576 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
08:20:27.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.651714  9529 sys_catalog.cc:455] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.652698  9529 sys_catalog.cc:458] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999 [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.680457  9576 catalog_manager.cc:1406] Generated new certificate authority record
08:20:27.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.682511  9576 catalog_manager.cc:1540] Loading token signing keys...
08:20:27.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.685509  9356 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } attempt: 7
08:20:27.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.725008  9576 catalog_manager.cc:6092] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68: Generated new TSK 0
08:20:27.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.726130  9576 catalog_manager.cc:1550] Initializing in-progress tserver states...
08:20:27.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.741525  9356 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: Bootstrap starting.
08:20:27.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.753801  9356 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: Neither blocks nor log segments found. Creating new log.
08:20:27.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.764051  9356 log.cc:826] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: Log is configured to *not* fsync() on all Append() calls
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.764688  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:27.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/logs
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data/info.pb
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:27.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.193:0
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.193
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.193
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:27.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:20:27.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.775549  9356 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: No bootstrap required, opened a new log
08:20:27.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.803541  9356 raft_consensus.cc:359] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.804999  9356 raft_consensus.cc:385] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:27.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.805799  9356 raft_consensus.cc:740] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7559d01e844642f596c7c910dd879dfd, State: Initialized, Role: FOLLOWER
08:20:27.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.807190  9356 consensus_queue.cc:260] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } }
08:20:27.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.820362  9606 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.826516  9606 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.822643  9308 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ffc524f0ca0e48de971c967106034d68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7559d01e844642f596c7c910dd879dfd"
08:20:27.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.823309  9309 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ffc524f0ca0e48de971c967106034d68" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7559d01e844642f596c7c910dd879dfd" is_pre_election: true
08:20:27.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.824317  9307 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [term 0 FOLLOWER]: Advancing to term 1
08:20:27.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.822432  9356 sys_catalog.cc:565] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: configured and running, proceeding with master startup.
08:20:27.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.836156  9307 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [term 1 FOLLOWER]: Refusing update from remote peer ffc524f0ca0e48de971c967106034d68: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:20:27.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.851946  9573 consensus_queue.cc:1048] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:20:27.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.948503  9606 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: SysCatalogTable state changed. Reason: New leader ffc524f0ca0e48de971c967106034d68. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.948643  9615 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:27.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.950341  9606 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.950392  9615 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd [sys.catalog]: This master's current role is: FOLLOWER
08:20:27.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:27.967686  9630 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
08:20:28.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.244668  9502 messenger.cc:194] Invalid argument: socket address is ambiguous: no data on pending connections for acceptor pool at 127.8.221.252:34571
08:20:28.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.407301  9546 catalog_manager.cc:1295] Loaded cluster ID: 857eba963900490fbbb7ea7f5c688f28
08:20:28.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.408178  9546 catalog_manager.cc:1588] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: loading cluster ID for follower catalog manager: success
08:20:28.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.416188  9546 catalog_manager.cc:1610] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: acquiring CA information for follower catalog manager: success
08:20:28.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.423353  9573 sys_catalog.cc:455] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ffc524f0ca0e48de971c967106034d68" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "cf54b267f9c644cbbb3f486a57d94999" member_type: VOTER last_known_addr { host: "127.8.221.254" port: 43959 } } peers { permanent_uuid: "7559d01e844642f596c7c910dd879dfd" member_type: VOTER last_known_addr { host: "127.8.221.253" port: 44091 } } peers { permanent_uuid: "ffc524f0ca0e48de971c967106034d68" member_type: VOTER last_known_addr { host: "127.8.221.252" port: 34571 } } }
08:20:28.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.424081  9573 sys_catalog.cc:458] T 00000000000000000000000000000000 P ffc524f0ca0e48de971c967106034d68 [sys.catalog]: This master's current role is: LEADER
08:20:28.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.423974  9546 catalog_manager.cc:1638] T 00000000000000000000000000000000 P cf54b267f9c644cbbb3f486a57d94999: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:20:28.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.441924  9600 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:28.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.442648  9600 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:28.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.443826  9600 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:28.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.504833  9600 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:28.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.506459  9600 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.221.193
08:20:28.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.571902  9600 tablet_server_runner.cc:78] Tablet server non-default flags:
08:20:28.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/logs
08:20:28.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:28.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:28.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.193:0
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data/info.pb
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.193
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:28.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:28.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:28.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:28.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:28.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.193
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:28.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:28.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.573690  9600 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:28.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.575954  9600 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:28.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.625180  9644 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:28.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.991384  9630 catalog_manager.cc:1295] Loaded cluster ID: 857eba963900490fbbb7ea7f5c688f28
08:20:28.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:28.994076  9630 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: loading cluster ID for follower catalog manager: success
08:20:29.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:29.001590  9630 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: acquiring CA information for follower catalog manager: success
08:20:29.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:29.033968  9630 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 7559d01e844642f596c7c910dd879dfd: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.013029  9643 debug-util.cc:398] Leaking SignalData structure 0x7b080002ee40 after lost signal to thread 9600
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.268006  9643 kernel_stack_watchdog.cc:198] Thread 9600 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 380ms:
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
08:20:30.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
08:20:30.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:28.630877  9646 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:30.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.270823  9648 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:30.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.273718  9600 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.643s	user 0.275s	sys 0.491s
08:20:30.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.273967  9647 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1642 milliseconds
08:20:30.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:30.274070  9600 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.644s	user 0.275s	sys 0.491s
08:20:30.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.274430  9600 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
08:20:30.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.275544  9600 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.286834  9600 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:30.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.295153  9600 hybrid_clock.cc:648] HybridClock initialized: now 1786522830295044 us; error 107 us; skew 500 ppm
08:20:30.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.296738  9600 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:30.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.326833  9600 webserver.cc:533] Webserver started at http://127.8.221.193:34945/ using document root <none> and password file <none>
08:20:30.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.328586  9600 fs_manager.cc:362] Metadata directory not provided
08:20:30.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.329160  9600 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:30.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.329973  9600 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:30.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.337000  9600 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data/instance:
08:20:30.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8aada780ac1341e6add3985c95431d5c"
08:20:30.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:30 on dist-test-slave-4tdj"
08:20:30.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.339239  9600 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal/instance:
08:20:30.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8aada780ac1341e6add3985c95431d5c"
08:20:30.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:30 on dist-test-slave-4tdj"
08:20:30.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.356143  9600 fs_manager.cc:696] Time spent creating directory manager: real 0.016s	user 0.001s	sys 0.012s
08:20:30.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.370124  9657 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:30.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.374131  9600 fs_manager.cc:730] Time spent opening block manager: real 0.013s	user 0.008s	sys 0.002s
08:20:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.377519  9600 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal
08:20:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8aada780ac1341e6add3985c95431d5c"
08:20:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:30 on dist-test-slave-4tdj"
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.378504  9600 fs_report.cc:389] FS layout report
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data/data
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:30.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:30.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:30.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:30.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.484500  9600 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:30.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.486570  9600 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:30.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.487142  9600 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:30.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.490933  9600 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:20:30.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.496963  9600 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:20:30.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.497259  9600 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:20:30.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.497545  9600 ts_tablet_manager.cc:616] Registered 0 tablets
08:20:30.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.497768  9600 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:20:30.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.736685  9600 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.193:33799
08:20:30.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.737478  9848 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.193:33799 every 8 connection(s)
08:20:30.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.740339  9600 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/data/info.pb
08:20:30.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.747594  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 9600
08:20:30.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.748035  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-0/wal/instance
08:20:30.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.814505  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:30.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:30.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal
08:20:30.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data
08:20:30.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/logs
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data/info.pb
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:30.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.194:0
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.194
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.194
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:30.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:20:30.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.832056  9857 heartbeater.cc:344] Connected to a master server at 127.8.221.254:43959
08:20:30.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.832578  9857 heartbeater.cc:461] Registering TS with master...
08:20:30.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.833891  9857 heartbeater.cc:507] Master 127.8.221.254:43959 requested a full tablet report, sending...
08:20:30.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.837653  9166 ts_manager.cc:194] Registered new tserver with Master: 8aada780ac1341e6add3985c95431d5c (127.8.221.193:33799)
08:20:30.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.838887  9849 heartbeater.cc:344] Connected to a master server at 127.8.221.252:34571
08:20:30.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.839236  9849 heartbeater.cc:461] Registering TS with master...
08:20:30.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.840130  9849 heartbeater.cc:507] Master 127.8.221.252:34571 requested a full tablet report, sending...
08:20:30.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.842672  9449 ts_manager.cc:194] Registered new tserver with Master: 8aada780ac1341e6add3985c95431d5c (127.8.221.193:33799)
08:20:30.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.845407  9449 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.221.193:50929
08:20:30.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.846505  9851 heartbeater.cc:344] Connected to a master server at 127.8.221.253:44091
08:20:30.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.846868  9851 heartbeater.cc:461] Registering TS with master...
08:20:30.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.847775  9851 heartbeater.cc:507] Master 127.8.221.253:44091 requested a full tablet report, sending...
08:20:30.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:30.851614  9290 ts_manager.cc:194] Registered new tserver with Master: 8aada780ac1341e6add3985c95431d5c (127.8.221.193:33799)
08:20:31.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.190225  9868 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:31.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.190819  9868 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:31.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.191383  9868 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:31.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.225046  9868 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:31.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.226148  9868 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.221.194
08:20:31.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:31.264828  9868 tablet_server_runner.cc:78] Tablet server non-default flags:
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/logs
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:31.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.194:0
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:31.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data/info.pb
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.194
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.194
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:20:31.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:31.266618  9868 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:31.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:31.269374  9868 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:31.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.285102  9876 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:31.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:31.854063  9849 heartbeater.cc:499] Master 127.8.221.252:34571 was elected leader, sending a full tablet report...
08:20:32.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:32.687031  9875 debug-util.cc:398] Leaking SignalData structure 0x7b080002ee40 after lost signal to thread 9868
08:20:32.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:32.797204  9868 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.511s	user 0.544s	sys 0.796s
08:20:32.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:32.797565  9868 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.512s	user 0.544s	sys 0.796s
08:20:32.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:31.286999  9877 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:32.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:32.799561  9882 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:32.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:32.802651  9881 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1512 milliseconds
08:20:32.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.802682  9868 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
08:20:32.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.803808  9868 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:32.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.805866  9868 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:32.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.807227  9868 hybrid_clock.cc:648] HybridClock initialized: now 1786522832807187 us; error 44 us; skew 500 ppm
08:20:32.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.808020  9868 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:32.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.813936  9868 webserver.cc:533] Webserver started at http://127.8.221.194:35131/ using document root <none> and password file <none>
08:20:32.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.814841  9868 fs_manager.cc:362] Metadata directory not provided
08:20:32.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.815034  9868 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:32.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.815470  9868 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:32.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.819885  9868 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data/instance:
08:20:32.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7"
08:20:32.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:32 on dist-test-slave-4tdj"
08:20:32.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.821139  9868 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal/instance:
08:20:32.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7"
08:20:32.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:32 on dist-test-slave-4tdj"
08:20:32.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.828222  9868 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.001s	sys 0.008s
08:20:32.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.833773  9902 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:32.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.834930  9868 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
08:20:32.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.835222  9868 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal
08:20:32.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7"
08:20:32.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:32 on dist-test-slave-4tdj"
08:20:32.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.835523  9868 fs_report.cc:389] FS layout report
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data/data
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:32.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:32.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.890434  9868 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:32.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.891942  9868 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:32.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.892356  9868 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:32.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.894984  9868 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:20:32.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.899187  9868 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:20:32.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.899381  9868 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:20:32.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.899585  9868 ts_tablet_manager.cc:616] Registered 0 tablets
08:20:32.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:32.899719  9868 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:20:33.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.038537  9868 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.194:41911
08:20:33.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.038661 10106 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.194:41911 every 8 connection(s)
08:20:33.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.041303  9868 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/data/info.pb
08:20:33.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.042681  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 9868
08:20:33.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.043402  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-1/wal/instance
08:20:33.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.054503  9079 external_mini_cluster.cc:1372] Running /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/logs
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data/info.pb
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:20:33.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.195:0
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.195
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.195
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:33.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:20:33.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.098686 10110 heartbeater.cc:344] Connected to a master server at 127.8.221.253:44091
08:20:33.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.099197 10110 heartbeater.cc:461] Registering TS with master...
08:20:33.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.103036 10110 heartbeater.cc:507] Master 127.8.221.253:44091 requested a full tablet report, sending...
08:20:33.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.106583  9290 ts_manager.cc:194] Registered new tserver with Master: 9d01327af8ef4d5bba2fb7b0f7724eb7 (127.8.221.194:41911)
08:20:33.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.106825 10107 heartbeater.cc:344] Connected to a master server at 127.8.221.252:34571
08:20:33.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.107148 10107 heartbeater.cc:461] Registering TS with master...
08:20:33.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.108047 10107 heartbeater.cc:507] Master 127.8.221.252:34571 requested a full tablet report, sending...
08:20:33.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.108078 10112 heartbeater.cc:344] Connected to a master server at 127.8.221.254:43959
08:20:33.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.108486 10112 heartbeater.cc:461] Registering TS with master...
08:20:33.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.109362 10112 heartbeater.cc:507] Master 127.8.221.254:43959 requested a full tablet report, sending...
08:20:33.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.110313  9449 ts_manager.cc:194] Registered new tserver with Master: 9d01327af8ef4d5bba2fb7b0f7724eb7 (127.8.221.194:41911)
08:20:33.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.111784  9449 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.221.194:56927
08:20:33.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.112286  9166 ts_manager.cc:194] Registered new tserver with Master: 9d01327af8ef4d5bba2fb7b0f7724eb7 (127.8.221.194:41911)
08:20:33.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.404047 10120 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:20:33.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.404594 10120 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:20:33.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.405164 10120 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:20:33.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.438098 10120 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:20:33.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.439098 10120 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.221.195
08:20:33.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.476408 10120 tablet_server_runner.cc:78] Tablet server non-default flags:
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/logs
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.221.212:42813
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.221.195:0
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data/info.pb
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.221.195
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.221.254:43959,127.8.221.253:44091,127.8.221.252:34571
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.221.195
08:20:33.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 70c51312f1186a8ae9f46647160b7730123f7601
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 07:43:20 UTC on e7f111948823
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 13303
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
08:20:33.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.478133 10120 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:20:33.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:33.479893 10120 file_cache.cc:504] Constructed file cache file cache with capacity 419430
08:20:33.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.492643 10133 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:34.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.115832 10107 heartbeater.cc:499] Master 127.8.221.252:34571 was elected leader, sending a full tablet report...
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.895758 10132 debug-util.cc:398] Leaking SignalData structure 0x7b080002ee40 after lost signal to thread 10120
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.956775 10132 kernel_stack_watchdog.cc:198] Thread 10120 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
08:20:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
08:20:34.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:33.494138 10134 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:34.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.958336 10120 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.466s	user 0.632s	sys 0.820s
08:20:34.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.958794 10120 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.466s	user 0.632s	sys 0.820s
08:20:34.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.959288 10137 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1463 milliseconds
08:20:34.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.960506 10120 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
08:20:34.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:34.960570 10138 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
08:20:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.964097 10120 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:20:34.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.966254 10120 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:20:34.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.967619 10120 hybrid_clock.cc:648] HybridClock initialized: now 1786522834967584 us; error 29 us; skew 500 ppm
08:20:34.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.968364 10120 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
08:20:34.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.974198 10120 webserver.cc:533] Webserver started at http://127.8.221.195:39465/ using document root <none> and password file <none>
08:20:34.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.975083 10120 fs_manager.cc:362] Metadata directory not provided
08:20:34.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.975265 10120 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:20:34.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.975652 10120 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:20:34.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.979863 10120 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data/instance:
08:20:34.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7c7134d62acb43d9844e432efefb7818"
08:20:34.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:34 on dist-test-slave-4tdj"
08:20:34.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.980931 10120 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal/instance:
08:20:34.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7c7134d62acb43d9844e432efefb7818"
08:20:34.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:34 on dist-test-slave-4tdj"
08:20:34.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.988098 10120 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.002s
08:20:34.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.993585 10148 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:20:34.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.994733 10120 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.995008 10120 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data,/tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7c7134d62acb43d9844e432efefb7818"
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 08:20:34 on dist-test-slave-4tdj"
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:34.995306 10120 fs_report.cc:389] FS layout report
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal
08:20:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data/data
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:20:34.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:20:35.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.067235 10120 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:20:35.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.068692 10120 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
08:20:35.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.069087 10120 kserver.cc:163] Server-wide thread pool size limit: 3276
08:20:35.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.071682 10120 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:20:35.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.075924 10120 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:20:35.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.076114 10120 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:20:35.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.076309 10120 ts_tablet_manager.cc:616] Registered 0 tablets
08:20:35.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.076442 10120 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:20:35.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.214175 10120 rpc_server.cc:307] RPC server started. Bound to: 127.8.221.195:36753
08:20:35.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.214282 10355 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.221.195:36753 every 8 connection(s)
08:20:35.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.216725 10120 server_base.cc:1193] Dumped server information to /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/data/info.pb
08:20:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.231034  9079 external_mini_cluster.cc:1434] Started /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu as pid 10120
08:20:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.231549  9079 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task3Irz5W/test-tmp/mini-kudu-cluster2790000454644023457/ts-2/wal/instance
08:20:35.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.263684 10357 heartbeater.cc:344] Connected to a master server at 127.8.221.252:34571
08:20:35.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.264235 10357 heartbeater.cc:461] Registering TS with master...
08:20:35.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.266522 10357 heartbeater.cc:507] Master 127.8.221.252:34571 requested a full tablet report, sending...
08:20:35.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.269663  9444 ts_manager.cc:194] Registered new tserver with Master: 7c7134d62acb43d9844e432efefb7818 (127.8.221.195:36753)
08:20:35.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.271512  9444 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.221.195:40767
08:20:35.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.278048 10358 heartbeater.cc:344] Connected to a master server at 127.8.221.253:44091
08:20:35.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.278409 10358 heartbeater.cc:461] Registering TS with master...
08:20:35.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.279013 10358 heartbeater.cc:507] Master 127.8.221.253:44091 requested a full tablet report, sending...
08:20:35.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.279990 10360 heartbeater.cc:344] Connected to a master server at 127.8.221.254:43959
08:20:35.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.280342 10360 heartbeater.cc:461] Registering TS with master...
08:20:35.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.280897 10360 heartbeater.cc:507] Master 127.8.221.254:43959 requested a full tablet report, sending...
08:20:35.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.281769  9290 ts_manager.cc:194] Registered new tserver with Master: 7c7134d62acb43d9844e432efefb7818 (127.8.221.195:36753)
08:20:35.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.283258  9166 ts_manager.cc:194] Registered new tserver with Master: 7c7134d62acb43d9844e432efefb7818 (127.8.221.195:36753)
08:20:35.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:35.302018  9079 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
08:20:35.315 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:20:35.316 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

08:20:35.327 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.221.254"
      port: 43959
    }
    bound_http_address {
      host: "127.8.221.254"
      port: 37821
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.221.253"
      port: 44091
    }
    bound_http_address {
      host: "127.8.221.253"
      port: 45589
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.221.252"
      port: 34571
    }
    bound_http_address {
      host: "127.8.221.252"
      port: 33433
    }
  }
}

08:20:35.330 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

08:20:35.332 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.221.193"
      port: 33799
    }
    bound_http_address {
      host: "127.8.221.193"
      port: 34945
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.221.194"
      port: 41911
    }
    bound_http_address {
      host: "127.8.221.194"
      port: 35131
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.221.195"
      port: 36753
    }
    bound_http_address {
      host: "127.8.221.195"
      port: 39465
    }
  }
}

08:20:35.333 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
08:20:35.511 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
08:20:35.567 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
08:20:35.715 [DEBUG - main] (Connection.java:748) [peer master-127.8.221.254:43959(127.8.221.254:43959)] connecting to peer
08:20:35.767 [DEBUG - main] (Connection.java:748) [peer master-127.8.221.252:34571(127.8.221.252:34571)] connecting to peer
08:20:35.768 [DEBUG - main] (Connection.java:748) [peer master-127.8.221.253:44091(127.8.221.253:44091)] connecting to peer
08:20:35.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:35.781836  9512 acceptor_pool.cc:311] unable to collect diagnostics on RPC socket 127.8.221.252:34571: Invalid argument: socket address is ambiguous
08:20:35.784 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.8.221.253:44091(127.8.221.253:44091)] Successfully connected to peer
08:20:35.785 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.8.221.252:34571(127.8.221.252:34571)] Successfully connected to peer
08:20:35.786 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.8.221.254:43959(127.8.221.254:43959)] Successfully connected to peer
08:20:35.877 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.8.221.253
08:20:35.877 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.8.221.254
08:20:35.877 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.8.221.252
08:20:36.087 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0x3b2f5643, L:/127.0.0.1:45182 - R:/127.8.221.253:44091] using SASL/PLAIN
08:20:36.087 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x0211bbbf, L:/127.0.0.1:58050 - R:/127.8.221.252:34571] using SASL/PLAIN
08:20:36.087 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x0e9674ae, L:/127.0.0.1:36124 - R:/127.8.221.254:43959] using SASL/PLAIN
08:20:36.126 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
08:20:36.127 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=446), Traces: [0ms] refreshing cache from master, [22ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.221.254:43959, [82ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.221.252:34571, [84ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.221.253:44091, [418ms] Sub RPC ConnectToMaster: received response from server master-127.8.221.254:43959: OK, [418ms] Sub RPC ConnectToMaster: received response from server master-127.8.221.253:44091: OK, [418ms] Sub RPC ConnectToMaster: received response from server master-127.8.221.252:34571: OK, deferred=null) after lookup
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.171290  9444 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:58050:
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786522821188"
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:20:36.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:20:36.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:36.173804  9444 catalog_manager.cc:7099] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1786522821188 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
08:20:36.272 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 9c766efa3ac74af3b3afb4826b0536f3
08:20:36.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.275619 10357 heartbeater.cc:499] Master 127.8.221.252:34571 was elected leader, sending a full tablet report...
08:20:36.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.286760  9993 tablet_service.cc:1511] Processing CreateTablet for tablet 7233924e38ae4af0bd5576687b18f9db (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786522821188 [id=9c766efa3ac74af3b3afb4826b0536f3]), partition=RANGE (key) PARTITION UNBOUNDED
08:20:36.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.285517 10240 tablet_service.cc:1511] Processing CreateTablet for tablet 7233924e38ae4af0bd5576687b18f9db (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786522821188 [id=9c766efa3ac74af3b3afb4826b0536f3]), partition=RANGE (key) PARTITION UNBOUNDED
08:20:36.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.290198 10240 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 7233924e38ae4af0bd5576687b18f9db. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:36.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.292702  9993 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 7233924e38ae4af0bd5576687b18f9db. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:36.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.308157  9744 tablet_service.cc:1511] Processing CreateTablet for tablet 7233924e38ae4af0bd5576687b18f9db (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786522821188 [id=9c766efa3ac74af3b3afb4826b0536f3]), partition=RANGE (key) PARTITION UNBOUNDED
08:20:36.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.309957  9744 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 7233924e38ae4af0bd5576687b18f9db. 1 dirs total, 0 dirs full, 0 dirs failed
08:20:36.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.319687 10427 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Bootstrap starting.
08:20:36.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.332659 10427 tablet_bootstrap.cc:654] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Neither blocks nor log segments found. Creating new log.
08:20:36.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.335355 10427 log.cc:826] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Log is configured to *not* fsync() on all Append() calls
08:20:36.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.341331 10430 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Bootstrap starting.
08:20:36.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.351075 10430 tablet_bootstrap.cc:654] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Neither blocks nor log segments found. Creating new log.
08:20:36.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.351426 10427 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: No bootstrap required, opened a new log
08:20:36.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.351948 10427 ts_tablet_manager.cc:1403] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Time spent bootstrapping tablet: real 0.033s	user 0.014s	sys 0.004s
08:20:36.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.354017 10430 log.cc:826] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Log is configured to *not* fsync() on all Append() calls
08:20:36.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.360034 10433 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Bootstrap starting.
08:20:36.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.367007 10430 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: No bootstrap required, opened a new log
08:20:36.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.367805 10430 ts_tablet_manager.cc:1403] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Time spent bootstrapping tablet: real 0.027s	user 0.012s	sys 0.010s
08:20:36.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.371178 10433 tablet_bootstrap.cc:654] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Neither blocks nor log segments found. Creating new log.
08:20:36.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.373528 10433 log.cc:826] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Log is configured to *not* fsync() on all Append() calls
08:20:36.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.385895 10427 raft_consensus.cc:359] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.386798 10427 raft_consensus.cc:385] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:36.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.386922 10433 tablet_bootstrap.cc:492] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: No bootstrap required, opened a new log
08:20:36.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.387108 10427 raft_consensus.cc:740] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9d01327af8ef4d5bba2fb7b0f7724eb7, State: Initialized, Role: FOLLOWER
08:20:36.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.387483 10433 ts_tablet_manager.cc:1403] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Time spent bootstrapping tablet: real 0.028s	user 0.011s	sys 0.009s
08:20:36.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.389048 10427 consensus_queue.cc:260] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.396379 10427 ts_tablet_manager.cc:1434] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Time spent starting tablet: real 0.044s	user 0.025s	sys 0.011s
08:20:36.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.401278 10430 raft_consensus.cc:359] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.402478 10430 raft_consensus.cc:385] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:36.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.402971 10430 raft_consensus.cc:740] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7c7134d62acb43d9844e432efefb7818, State: Initialized, Role: FOLLOWER
08:20:36.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.404122 10430 consensus_queue.cc:260] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.414531 10430 ts_tablet_manager.cc:1434] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Time spent starting tablet: real 0.046s	user 0.026s	sys 0.013s
08:20:36.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.427807 10433 raft_consensus.cc:359] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.428563 10433 raft_consensus.cc:385] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:20:36.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.428886 10433 raft_consensus.cc:740] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 8aada780ac1341e6add3985c95431d5c, State: Initialized, Role: FOLLOWER
08:20:36.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.429979 10433 consensus_queue.cc:260] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.433704 10433 ts_tablet_manager.cc:1434] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Time spent starting tablet: real 0.046s	user 0.029s	sys 0.006s
08:20:36.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:36.487524 10369 tablet.cc:2406] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:20:36.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:36.551105  9862 tablet.cc:2406] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:20:36.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.554839 10441 raft_consensus.cc:493] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:20:36.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.555290 10441 raft_consensus.cc:515] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.557760 10441 leader_election.cc:290] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 9d01327af8ef4d5bba2fb7b0f7724eb7 (127.8.221.194:41911), 7c7134d62acb43d9844e432efefb7818 (127.8.221.195:36753)
08:20:36.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.569519 10026 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "7233924e38ae4af0bd5576687b18f9db" candidate_uuid: "8aada780ac1341e6add3985c95431d5c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" is_pre_election: true
08:20:36.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.570408 10026 raft_consensus.cc:2468] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 8aada780ac1341e6add3985c95431d5c in term 0.
08:20:36.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.570606 10282 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "7233924e38ae4af0bd5576687b18f9db" candidate_uuid: "8aada780ac1341e6add3985c95431d5c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7c7134d62acb43d9844e432efefb7818" is_pre_election: true
08:20:36.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.571429 10282 raft_consensus.cc:2468] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 8aada780ac1341e6add3985c95431d5c in term 0.
08:20:36.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.571631  9658 leader_election.cc:304] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 8aada780ac1341e6add3985c95431d5c, 9d01327af8ef4d5bba2fb7b0f7724eb7; no voters: 
08:20:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.572738 10441 raft_consensus.cc:2804] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Leader pre-election won for term 1
08:20:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.572999 10441 raft_consensus.cc:493] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:20:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.573217 10441 raft_consensus.cc:3060] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 0 FOLLOWER]: Advancing to term 1
08:20:36.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.577489 10441 raft_consensus.cc:515] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.578912 10441 leader_election.cc:290] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [CANDIDATE]: Term 1 election: Requested vote from peers 9d01327af8ef4d5bba2fb7b0f7724eb7 (127.8.221.194:41911), 7c7134d62acb43d9844e432efefb7818 (127.8.221.195:36753)
08:20:36.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.579643 10026 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "7233924e38ae4af0bd5576687b18f9db" candidate_uuid: "8aada780ac1341e6add3985c95431d5c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7"
08:20:36.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.579917 10282 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "7233924e38ae4af0bd5576687b18f9db" candidate_uuid: "8aada780ac1341e6add3985c95431d5c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7c7134d62acb43d9844e432efefb7818"
08:20:36.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.580169 10026 raft_consensus.cc:3060] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 0 FOLLOWER]: Advancing to term 1
08:20:36.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.580413 10282 raft_consensus.cc:3060] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 0 FOLLOWER]: Advancing to term 1
08:20:36.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.587539 10282 raft_consensus.cc:2468] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 8aada780ac1341e6add3985c95431d5c in term 1.
08:20:36.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.587513 10026 raft_consensus.cc:2468] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 8aada780ac1341e6add3985c95431d5c in term 1.
08:20:36.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.588610  9660 leader_election.cc:304] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 7c7134d62acb43d9844e432efefb7818, 8aada780ac1341e6add3985c95431d5c; no voters: 
08:20:36.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.589359 10441 raft_consensus.cc:2804] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 1 FOLLOWER]: Leader election won for term 1
08:20:36.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.591215 10441 raft_consensus.cc:697] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [term 1 LEADER]: Becoming Leader. State: Replica: 8aada780ac1341e6add3985c95431d5c, State: Running, Role: LEADER
08:20:36.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.592639 10441 consensus_queue.cc:237] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } }
08:20:36.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 08:20:36.597083 10121 tablet.cc:2406] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:20:36.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.607254  9444 catalog_manager.cc:5719] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c reported cstate change: term changed from 0 to 1, leader changed from <none> to 8aada780ac1341e6add3985c95431d5c (127.8.221.193). New cstate: current_term: 1 leader_uuid: "8aada780ac1341e6add3985c95431d5c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "8aada780ac1341e6add3985c95431d5c" member_type: VOTER last_known_addr { host: "127.8.221.193" port: 33799 } health_report { overall_health: HEALTHY } } }
08:20:36.725 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 7233924e38ae4af0bd5576687b18f9db for table 'org.apache.kudu.client.TestHybridTime-1786522821188' with partition [<start>, <end>)
08:20:36.731 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=7233924e38ae4af0bd5576687b18f9db@[7c7134d62acb43d9844e432efefb7818(127.8.221.195:36753),8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)[L],9d01327af8ef4d5bba2fb7b0f7724eb7(127.8.221.194:41911)]}]
08:20:36.732 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.8.221.252:34571, [9ms] Sub RPC GetTableLocations: received response from server master-127.8.221.252:34571: OK, deferred=null) after lookup
08:20:36.743 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)] connecting to peer
08:20:36.746 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)] Successfully connected to peer
08:20:36.816 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0xe5999a07, L:/127.0.0.1:37658 - R:/127.8.221.193:33799] using TOKEN/null
08:20:36.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.831019 10282 raft_consensus.cc:1275] T 7233924e38ae4af0bd5576687b18f9db P 7c7134d62acb43d9844e432efefb7818 [term 1 FOLLOWER]: Refusing update from remote peer 8aada780ac1341e6add3985c95431d5c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:20:36.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.831331 10026 raft_consensus.cc:1275] T 7233924e38ae4af0bd5576687b18f9db P 9d01327af8ef4d5bba2fb7b0f7724eb7 [term 1 FOLLOWER]: Refusing update from remote peer 8aada780ac1341e6add3985c95431d5c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:20:36.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.832710 10441 consensus_queue.cc:1048] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [LEADER]: Connected to new peer: Peer: permanent_uuid: "7c7134d62acb43d9844e432efefb7818" member_type: VOTER last_known_addr { host: "127.8.221.195" port: 36753 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:20:36.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.833564 10444 consensus_queue.cc:1048] T 7233924e38ae4af0bd5576687b18f9db P 8aada780ac1341e6add3985c95431d5c [LEADER]: Connected to new peer: Peer: permanent_uuid: "9d01327af8ef4d5bba2fb7b0f7724eb7" member_type: VOTER last_known_addr { host: "127.8.221.194" port: 41911 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
08:20:36.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:36.861057 10450 mvcc.cc:204] Tried to move back new op lower bound from 7317597539641339904 to 7317597538694156288. Current Snapshot: MvccSnapshot[applied={T|T < 7317597539641339904}]
08:20:36.923 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:36.951 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:36.966 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:36.979 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1206041189(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:20:37.000 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:37.000 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@421408255(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:20:37.017 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:37.017 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@453402262(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:20:37.046 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:20:37.111 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.127 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317597560121339905) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.140 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317597560121339909) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.154 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317597560121339913) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.165 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317597560121339917) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.178 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317597560121339921) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.189 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317597560121339925) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.200 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317597560121339926) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786522821188, tablet=7233924e38ae4af0bd5576687b18f9db, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:20:37.204 [DEBUG - main] (Connection.java:575) [peer master-127.8.221.253:44091(127.8.221.253:44091)] disconnecting while in state READY
08:20:37.205 [DEBUG - main] (Connection.java:575) [peer 8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)] disconnecting while in state READY
08:20:37.206 [DEBUG - main] (Connection.java:575) [peer master-127.8.221.254:43959(127.8.221.254:43959)] disconnecting while in state READY
08:20:37.206 [DEBUG - main] (Connection.java:575) [peer master-127.8.221.252:34571(127.8.221.252:34571)] disconnecting while in state READY
08:20:37.212 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.8.221.254:43959(127.8.221.254:43959)] handling channelInactive
08:20:37.213 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.8.221.254:43959(127.8.221.254:43959)] cleaning up while in state READY due to: connection closed
08:20:37.213 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.8.221.252:34571(127.8.221.252:34571)] handling channelInactive
08:20:37.213 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.8.221.252:34571(127.8.221.252:34571)] cleaning up while in state READY due to: connection closed
08:20:37.215 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)] handling channelInactive
08:20:37.215 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 8aada780ac1341e6add3985c95431d5c(127.8.221.193:33799)] cleaning up while in state READY due to: connection closed
08:20:37.215 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
08:20:37.222 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.8.221.253:44091(127.8.221.253:44091)] handling channelInactive
08:20:37.222 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.8.221.253:44091(127.8.221.253:44091)] cleaning up while in state READY due to: connection closed
08:20:37.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.222736  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 9600
08:20:37.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.293574  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 9868
08:20:37.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.367056  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 10120
08:20:37.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.404290  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 9105
08:20:37.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.432884  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 9228
08:20:37.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 08:20:37.462370  9079 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task3Irz5W/build/tsan/bin/kudu with pid 9359
08:20:38.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T08:20:38Z chronyd exiting

Time: 18.56

OK (1 test)

