JUnit version 4.13.2
.19:44:05.562 [INFO - main] (RandomUtils.java:49) Using random seed: 1786477445555
19:44:05.582 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
19:44:05.642 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
19:44:05.651 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task7bLwl_/test-tmp
19:44:05.654 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
19:44:05.658 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task7bLwl_/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
19:44:06.024 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

19:44:06.186 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
19:44:06.188 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

19:44:06.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.192252 19461 mini_oidc.cc:152] Starting JWKS server
19:44:06.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.196548 19461 webserver.cc:460] Webserver started at http://127.0.0.1:45037/ using document root <none> and password file <none>
19:44:06.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.197335 19461 mini_oidc.cc:189] Starting OIDC Discovery server
19:44:06.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.199617 19461 webserver.cc:460] Webserver started at http://127.0.0.1:34603/ using document root <none> and password file <none>
19:44:06.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T19:44:06Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
19:44:06.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T19:44:06Z Disabled control of system clock
19:44:06.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.267097 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:06.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:06.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal
19:44:06.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data
19:44:06.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:06.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:06.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:06.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:06.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:06.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:06.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/logs
19:44:06.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data/info.pb
19:44:06.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:06.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:06.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.126:45231
19:44:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.126
19:44:06.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:06.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:06.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:06.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:06.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:06.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json with env {}
19:44:06.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.611649 19473 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:06.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.612362 19473 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:06.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.612975 19473 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:06.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.646157 19473 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
19:44:06.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.646471 19473 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:06.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.646665 19473 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
19:44:06.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.646847 19473 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
19:44:06.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.647044 19473 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
19:44:06.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.647174 19473 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45037/jwks.json
19:44:06.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.690466 19473 master_runner.cc:386] Master server non-default flags:
19:44:06.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:06.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:06.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:06.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:06.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data
19:44:06.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.126:45231
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:06.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data/info.pb
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.126
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/logs
19:44:06.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:06.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:06.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:06.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:06.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:06.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.691922 19473 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:06.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.693867 19473 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:06.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.716549 19480 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
19:44:07.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:06.720618 19473 server_base.cc:1034] running on GCE node
19:44:07.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.718616 19481 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
19:44:07.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:06.716624 19483 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
19:44:08.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.011088 19473 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:08.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.014321 19473 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:08.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.018074 19473 hybrid_clock.cc:648] HybridClock initialized: now 1786477448017643 us; error 521 us; skew 500 ppm
19:44:08.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.019237 19473 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:08.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.033560 19473 webserver.cc:460] Webserver started at http://127.19.1.126:36903/ using document root <none> and password file <none>
19:44:08.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.034675 19473 fs_manager.cc:359] Metadata directory not provided
19:44:08.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.034927 19473 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:08.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.035401 19473 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:08.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.042747 19473 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data/instance:
19:44:08.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e122ce7f4ea4b168dd2d196455c094d"
19:44:08.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:08 on dist-test-slave-mvvj"
19:44:08.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.044360 19473 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal/instance:
19:44:08.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e122ce7f4ea4b168dd2d196455c094d"
19:44:08.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:08 on dist-test-slave-mvvj"
19:44:08.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.054203 19473 fs_manager.cc:691] Time spent creating directory manager: real 0.009s	user 0.004s	sys 0.004s
19:44:08.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.064780 19493 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:08.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.066998 19473 fs_manager.cc:725] Time spent opening block manager: real 0.009s	user 0.008s	sys 0.000s
19:44:08.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.067420 19473 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal
19:44:08.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e122ce7f4ea4b168dd2d196455c094d"
19:44:08.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:08 on dist-test-slave-mvvj"
19:44:08.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.068014 19473 fs_report.cc:383] FS layout report
19:44:08.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:08.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal
19:44:08.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal
19:44:08.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data/data
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:08.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.142558 19473 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:08.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.144348 19473 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:08.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.144943 19473 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:08.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.243698 19473 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.126:45231
19:44:08.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.243712 19550 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.126:45231 every 8 connection(s)
19:44:08.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.247526 19473 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/data/info.pb
19:44:08.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.255697 19551 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:08.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.258797 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 19473
19:44:08.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.259459 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-0/wal/instance
19:44:08.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.264107 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:08.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/logs
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data/info.pb
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:08.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:08.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:08.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:08.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.125:39715
19:44:08.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.125
19:44:08.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:08.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:08.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:08.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:08.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:08.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:08.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:08.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:08.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json with env {}
19:44:08.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.271169 19551 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } has no permanent_uuid. Determining permanent_uuid...
19:44:08.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.313333 19551 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } has no permanent_uuid. Determining permanent_uuid...
19:44:08.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.316462 19496 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.321535 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.371204 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 1
19:44:08.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.376006 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.444514 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 2
19:44:08.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.449061 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.540593 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 3
19:44:08.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.545842 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.638520 19554 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:08.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.639307 19554 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:08.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.640079 19554 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:08.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.674307 19554 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
19:44:08.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.674760 19554 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:08.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.675112 19554 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
19:44:08.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.675489 19554 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
19:44:08.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.675909 19554 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
19:44:08.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.676177 19554 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45037/jwks.json
19:44:08.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.689311 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 4
19:44:08.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.694969 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:08.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.726940 19554 master_runner.cc:386] Master server non-default flags:
19:44:08.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:08.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.125:39715
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:08.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data/info.pb
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.125
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:08.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:08.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:08.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:08.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:08.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:08.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/logs
19:44:08.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:08.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:08.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:08.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:08.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.728883 19554 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:08.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.732788 19554 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:08.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.761947 19566 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
19:44:08.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.994731 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 5
19:44:09.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:09.001849 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:09.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:09.549360 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 6
19:44:09.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:09.557191 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.125:39715: Network error: Client connection negotiation failed: client connection to 127.19.1.125:39715: connect: Connection refused (error 111)
19:44:10.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.761935 19564 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
19:44:10.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:08.765614 19554 server_base.cc:1034] running on GCE node
19:44:10.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:08.761935 19563 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
19:44:10.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.064273 19554 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:10.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.068087 19554 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:10.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.070618 19554 hybrid_clock.cc:648] HybridClock initialized: now 1786477450070550 us; error 76 us; skew 500 ppm
19:44:10.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.072288 19554 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:10.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.081314 19554 webserver.cc:460] Webserver started at http://127.19.1.125:45717/ using document root <none> and password file <none>
19:44:10.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.083204 19554 fs_manager.cc:359] Metadata directory not provided
19:44:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.083539 19554 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:10.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.084184 19554 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.091560 19554 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data/instance:
19:44:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1c36be20aee649529fcbb47941b0be7d"
19:44:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:10 on dist-test-slave-mvvj"
19:44:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.093101 19554 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal/instance:
19:44:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1c36be20aee649529fcbb47941b0be7d"
19:44:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:10 on dist-test-slave-mvvj"
19:44:10.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.104142 19554 fs_manager.cc:691] Time spent creating directory manager: real 0.010s	user 0.006s	sys 0.005s
19:44:10.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.113036 19582 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:10.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.115242 19554 fs_manager.cc:725] Time spent opening block manager: real 0.006s	user 0.001s	sys 0.003s
19:44:10.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.115666 19554 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal
19:44:10.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1c36be20aee649529fcbb47941b0be7d"
19:44:10.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:10 on dist-test-slave-mvvj"
19:44:10.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.116174 19554 fs_report.cc:383] FS layout report
19:44:10.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:10.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal
19:44:10.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal
19:44:10.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data/data
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:10.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:10.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:10.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:10.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.167491 19554 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:10.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.169445 19554 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:10.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.170070 19554 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:10.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.278784 19554 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.125:39715
19:44:10.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.278853 19636 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.125:39715 every 8 connection(s)
19:44:10.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.284654 19554 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/data/info.pb
19:44:10.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.289490 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 19554
19:44:10.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.290060 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-1/wal/instance
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.293589 19637 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.293628 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/logs
19:44:10.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data/info.pb
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.124:35639
19:44:10.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.124
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:10.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json with env {}
19:44:10.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.317281 19637 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } has no permanent_uuid. Determining permanent_uuid...
19:44:10.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.350956 19637 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } has no permanent_uuid. Determining permanent_uuid...
19:44:10.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.372174 19637 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } has no permanent_uuid. Determining permanent_uuid...
19:44:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.374948 19584 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.380358 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.430179 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 1
19:44:10.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.434962 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.503690 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 2
19:44:10.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.508594 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.600119 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 3
19:44:10.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.605075 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.617987 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } attempt: 7
19:44:10.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.632936 19551 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } has no permanent_uuid. Determining permanent_uuid...
19:44:10.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.639593 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.692480 19639 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:10.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.693365 19639 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:10.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.694507 19639 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:10.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.698144 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 1
19:44:10.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.704053 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.737004 19639 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
19:44:10.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.737370 19639 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:10.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.737676 19639 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
19:44:10.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.737872 19639 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
19:44:10.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.738062 19639 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
19:44:10.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.738196 19639 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45037/jwks.json
19:44:10.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.748593 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 4
19:44:10.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.752948 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.785786 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 2
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.786010 19639 master_runner.cc:386] Master server non-default flags:
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data
19:44:10.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.124:35639
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45037/jwks.json
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:10.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data/info.pb
19:44:10.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.124
19:44:10.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:10.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:10.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/logs
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.787954 19639 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:10.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.790601 19639 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:10.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.791785 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:10.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.814967 19654 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
19:44:10.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.877346 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 3
19:44:10.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.884137 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:11.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:11.024621 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 4
19:44:11.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:11.029642 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:11.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:11.052539 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 5
19:44:11.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:11.057073 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:11.313170 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 5
19:44:11.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:11.318874 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:11.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:11.604554 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 6
19:44:11.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:11.612464 19637 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:11.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:11.871434 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 6
19:44:11.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:11.879750 19551 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.19.1.124:35639: Network error: Client connection negotiation failed: client connection to 127.19.1.124:35639: connect: Connection refused (error 111)
19:44:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.815021 19652 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
19:44:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:10.817740 19639 server_base.cc:1034] running on GCE node
19:44:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:10.815021 19656 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
19:44:12.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.144757 19639 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:12.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.148244 19639 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:12.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.149897 19639 hybrid_clock.cc:648] HybridClock initialized: now 1786477452149846 us; error 77 us; skew 500 ppm
19:44:12.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.151022 19639 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:12.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.158896 19639 webserver.cc:460] Webserver started at http://127.19.1.124:40263/ using document root <none> and password file <none>
19:44:12.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.160197 19639 fs_manager.cc:359] Metadata directory not provided
19:44:12.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.160436 19639 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:12.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.160900 19639 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:12.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.166817 19639 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data/instance:
19:44:12.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3756673e3c79403da723b7ada323d314"
19:44:12.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:12 on dist-test-slave-mvvj"
19:44:12.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.168293 19639 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal/instance:
19:44:12.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3756673e3c79403da723b7ada323d314"
19:44:12.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:12 on dist-test-slave-mvvj"
19:44:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.177100 19639 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.007s	sys 0.001s
19:44:12.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.184139 19668 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:12.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.185611 19639 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.001s
19:44:12.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.185969 19639 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal
19:44:12.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3756673e3c79403da723b7ada323d314"
19:44:12.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:12 on dist-test-slave-mvvj"
19:44:12.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.186327 19639 fs_report.cc:383] FS layout report
19:44:12.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data/data
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:12.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.226645 19639 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:12.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.228457 19639 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:12.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.228941 19639 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:12.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.328495 19639 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.124:35639
19:44:12.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.328684 19725 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.124:35639 every 8 connection(s)
19:44:12.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.333120 19639 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/data/info.pb
19:44:12.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.340184 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 19639
19:44:12.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.340688 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/master-2/wal/instance
19:44:12.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.341464 19726 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:12.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.362025 19726 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } has no permanent_uuid. Determining permanent_uuid...
19:44:12.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.402298 19726 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } has no permanent_uuid. Determining permanent_uuid...
19:44:12.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.416643 19726 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } has no permanent_uuid. Determining permanent_uuid...
19:44:12.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.438771 19726 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: Bootstrap starting.
19:44:12.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.445223 19726 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: Neither blocks nor log segments found. Creating new log.
19:44:12.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.447995 19726 log.cc:824] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: Log is configured to *not* fsync() on all Append() calls
19:44:12.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.453516 19726 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: No bootstrap required, opened a new log
19:44:12.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.476799 19726 raft_consensus.cc:348] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.477586 19726 raft_consensus.cc:374] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:12.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.477974 19726 raft_consensus.cc:729] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3756673e3c79403da723b7ada323d314, State: Initialized, Role: FOLLOWER
19:44:12.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.479137 19726 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.483462 19736 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:12.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.484544 19736 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: This master's current role is: FOLLOWER
19:44:12.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.485328 19674 tablet.cc:2369] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:12.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.485499 19726 sys_catalog.cc:564] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: configured and running, proceeding with master startup.
19:44:12.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.513262 19747 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
19:44:12.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.513671 19747 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
19:44:12.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.509363 19639 master_runner.cc:186] Error getting master registration for 127.19.1.126:45231: OK, instance_id { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" instance_seqno: 1786477448216859 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
19:44:12.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.550339 19639 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
19:44:12.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.673043 19637 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 7
19:44:12.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.700129 19637 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: Bootstrap starting.
19:44:12.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.709558 19637 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: Neither blocks nor log segments found. Creating new log.
19:44:12.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.712561 19637 log.cc:824] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: Log is configured to *not* fsync() on all Append() calls
19:44:12.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.718748 19637 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: No bootstrap required, opened a new log
19:44:12.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.753782 19637 raft_consensus.cc:348] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.754720 19637 raft_consensus.cc:374] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:12.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.755007 19637 raft_consensus.cc:729] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1c36be20aee649529fcbb47941b0be7d, State: Initialized, Role: FOLLOWER
19:44:12.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.756065 19637 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.758682 19736 raft_consensus.cc:482] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
19:44:12.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.759300 19736 raft_consensus.cc:504] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.762339 19637 sys_catalog.cc:564] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: configured and running, proceeding with master startup.
19:44:12.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.764552 19751 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:12.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.767514 19736 leader_election.cc:288] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 7e122ce7f4ea4b168dd2d196455c094d (127.19.1.126:45231), 1c36be20aee649529fcbb47941b0be7d (127.19.1.125:39715)
19:44:12.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.769929 19751 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: This master's current role is: FOLLOWER
19:44:12.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.770030 19610 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3756673e3c79403da723b7ada323d314" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1c36be20aee649529fcbb47941b0be7d" is_pre_election: true
19:44:12.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.771181 19610 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3756673e3c79403da723b7ada323d314 in term 0.
19:44:12.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.772742 19671 leader_election.cc:302] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [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: 1c36be20aee649529fcbb47941b0be7d, 3756673e3c79403da723b7ada323d314; no voters: 
19:44:12.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.774008 19736 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Leader pre-election won for term 1
19:44:12.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.774521 19736 raft_consensus.cc:482] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
19:44:12.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.774916 19736 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 0 FOLLOWER]: Advancing to term 1
19:44:12.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.783761 19736 raft_consensus.cc:504] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.788065 19736 leader_election.cc:288] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [CANDIDATE]: Term 1 election: Requested vote from peers 7e122ce7f4ea4b168dd2d196455c094d (127.19.1.126:45231), 1c36be20aee649529fcbb47941b0be7d (127.19.1.125:39715)
19:44:12.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.789362 19610 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3756673e3c79403da723b7ada323d314" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1c36be20aee649529fcbb47941b0be7d"
19:44:12.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.790050 19610 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 0 FOLLOWER]: Advancing to term 1
19:44:12.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.809425 19610 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3756673e3c79403da723b7ada323d314 in term 1.
19:44:12.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.811733 19671 leader_election.cc:302] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [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: 1c36be20aee649529fcbb47941b0be7d, 3756673e3c79403da723b7ada323d314; no voters: 
19:44:12.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.812727 19736 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 1 FOLLOWER]: Leader election won for term 1
19:44:12.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.832604 19736 raft_consensus.cc:686] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [term 1 LEADER]: Becoming Leader. State: Replica: 3756673e3c79403da723b7ada323d314, State: Running, Role: LEADER
19:44:12.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.834254 19736 consensus_queue.cc:237] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:12.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.879060 19764 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 3756673e3c79403da723b7ada323d314. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:12.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.884074 19764 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: This master's current role is: LEADER
19:44:12.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.895262 19768 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
19:44:12.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.895601 19765 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
19:44:12.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.895990 19765 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
19:44:12.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.904266 19768 catalog_manager.cc:1484] Initializing Kudu cluster ID...
19:44:12.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.913470 19551 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } attempt: 7
19:44:12.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:12.930732 19588 tablet.cc:2369] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:12.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.942616 19610 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [term 1 FOLLOWER]: Refusing update from remote peer 3756673e3c79403da723b7ada323d314: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:44:12.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.847798 19554 master_runner.cc:186] Error getting master registration for 127.19.1.126:45231: OK, instance_id { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" instance_seqno: 1786477448216859 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
19:44:12.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.944571 19764 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [LEADER]: Connected to new peer: Peer: permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:44:12.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.947631 19554 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
19:44:12.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.968652 19551 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: Bootstrap starting.
19:44:12.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.977322 19551 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: Neither blocks nor log segments found. Creating new log.
19:44:12.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.980322 19551 log.cc:824] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: Log is configured to *not* fsync() on all Append() calls
19:44:12.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.992141 19551 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: No bootstrap required, opened a new log
19:44:12.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.992003 19751 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 3756673e3c79403da723b7ada323d314. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:12.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.992794 19751 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: This master's current role is: FOLLOWER
19:44:12.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:12.993382 19769 mvcc.cc:205] Tried to move back new op lower bound from 7317411647233044480 to 7317411646835200000. Current Snapshot: MvccSnapshot[applied={T|T < 7317411647233044480}]
19:44:13.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.008157 19736 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.009418 19736 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: This master's current role is: LEADER
19:44:13.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.021338 19768 catalog_manager.cc:1347] Generated new cluster ID: 4280f2a4137244c78288696250b166a3
19:44:13.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.021778 19768 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
19:44:13.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.062290 19551 raft_consensus.cc:348] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:13.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.071640 19751 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.072504 19751 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d [sys.catalog]: This master's current role is: FOLLOWER
19:44:13.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.075990 19551 raft_consensus.cc:374] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:13.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.076396 19551 raft_consensus.cc:729] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7e122ce7f4ea4b168dd2d196455c094d, State: Initialized, Role: FOLLOWER
19:44:13.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.077816 19551 consensus_queue.cc:260] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } }
19:44:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.087630 19768 catalog_manager.cc:1370] Generated new certificate authority record
19:44:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.088557 19778 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [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: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.090678 19768 catalog_manager.cc:1504] Loading token signing keys...
19:44:13.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.090991 19551 sys_catalog.cc:564] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: configured and running, proceeding with master startup.
19:44:13.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.096035 19778 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: This master's current role is: FOLLOWER
19:44:13.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.091437 19522 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3756673e3c79403da723b7ada323d314" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7e122ce7f4ea4b168dd2d196455c094d" is_pre_election: true
19:44:13.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.092742 19520 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [term 0 FOLLOWER]: Advancing to term 1
19:44:13.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.093276 19521 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3756673e3c79403da723b7ada323d314" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7e122ce7f4ea4b168dd2d196455c094d"
19:44:13.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.119941 19768 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314: Generated new TSK 0
19:44:13.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.121240 19768 catalog_manager.cc:1514] Initializing in-progress tserver states...
19:44:13.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.126107 19520 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [term 1 FOLLOWER]: Refusing update from remote peer 3756673e3c79403da723b7ada323d314: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:44:13.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.127974 19736 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:44:13.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.146994 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:13.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:13.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal
19:44:13.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/logs
19:44:13.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data/info.pb
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.65:0
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.65
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.65
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:13.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:44:13.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.157321 19500 tablet.cc:2369] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.208068 19791 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.209678 19791 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: This master's current role is: FOLLOWER
19:44:13.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.211772 19778 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 3756673e3c79403da723b7ada323d314. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.212658 19778 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d [sys.catalog]: This master's current role is: FOLLOWER
19:44:13.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.212410 19796 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
19:44:13.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.729272 19786 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:13.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.730752 19786 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:13.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.732095 19786 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:13.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.742062 19736 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "3756673e3c79403da723b7ada323d314" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7e122ce7f4ea4b168dd2d196455c094d" member_type: VOTER last_known_addr { host: "127.19.1.126" port: 45231 } } peers { permanent_uuid: "1c36be20aee649529fcbb47941b0be7d" member_type: VOTER last_known_addr { host: "127.19.1.125" port: 39715 } } peers { permanent_uuid: "3756673e3c79403da723b7ada323d314" member_type: VOTER last_known_addr { host: "127.19.1.124" port: 35639 } } }
19:44:13.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.743221 19736 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3756673e3c79403da723b7ada323d314 [sys.catalog]: This master's current role is: LEADER
19:44:13.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.778450 19786 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:13.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.779698 19786 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.19.1.65
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.818858 19786 tablet_server_runner.cc:78] Tablet server non-default flags:
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:13.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.65:0
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data/info.pb
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.65
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:13.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.65
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/logs
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:13.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.820531 19786 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:13.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.822978 19786 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:13.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.860893 19806 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
19:44:13.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.913700 19765 catalog_manager.cc:1259] Loaded cluster ID: 4280f2a4137244c78288696250b166a3
19:44:13.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.914582 19765 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: loading cluster ID for follower catalog manager: success
19:44:13.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.940335 19765 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: acquiring CA information for follower catalog manager: success
19:44:13.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:13.960907 19765 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 1c36be20aee649529fcbb47941b0be7d: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
19:44:14.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:14.237860 19796 catalog_manager.cc:1259] Loaded cluster ID: 4280f2a4137244c78288696250b166a3
19:44:14.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:14.238950 19796 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: loading cluster ID for follower catalog manager: success
19:44:14.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:14.262765 19796 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: acquiring CA information for follower catalog manager: success
19:44:14.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:14.275013 19796 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 7e122ce7f4ea4b168dd2d196455c094d: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
19:44:16.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.865645 19809 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
19:44:16.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:13.862860 19805 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
19:44:16.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.331357 19786 server_base.cc:1029] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
19:44:16.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:16.332048 19807 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 2472 milliseconds
19:44:16.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.334012 19786 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:16.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.342681 19786 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:16.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.344213 19786 hybrid_clock.cc:648] HybridClock initialized: now 1786477456344134 us; error 91 us; skew 500 ppm
19:44:16.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.345436 19786 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.359766 19786 webserver.cc:460] Webserver started at http://127.19.1.65:45017/ using document root <none> and password file <none>
19:44:16.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.361464 19786 fs_manager.cc:359] Metadata directory not provided
19:44:16.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.361815 19786 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:16.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.362454 19786 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:16.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.371079 19786 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data/instance:
19:44:16.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b150520519cb496e834a80b39f1c03bd"
19:44:16.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:16 on dist-test-slave-mvvj"
19:44:16.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.373212 19786 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal/instance:
19:44:16.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b150520519cb496e834a80b39f1c03bd"
19:44:16.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:16 on dist-test-slave-mvvj"
19:44:16.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.385097 19786 fs_manager.cc:691] Time spent creating directory manager: real 0.011s	user 0.010s	sys 0.001s
19:44:16.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.394675 19819 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:16.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.396381 19786 fs_manager.cc:725] Time spent opening block manager: real 0.006s	user 0.006s	sys 0.000s
19:44:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.397296 19786 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal
19:44:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b150520519cb496e834a80b39f1c03bd"
19:44:16.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:16 on dist-test-slave-mvvj"
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.398165 19786 fs_report.cc:383] FS layout report
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data/data
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:16.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.464941 19786 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:16.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.467276 19786 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:16.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.468057 19786 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.472159 19786 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
19:44:16.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.479252 19786 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:44:16.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.479581 19786 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:44:16.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.479939 19786 ts_tablet_manager.cc:610] Registered 0 tablets
19:44:16.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.480144 19786 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:44:16.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.679733 19786 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.65:37163
19:44:16.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.679898 19946 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.65:37163 every 8 connection(s)
19:44:16.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.682663 19786 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/data/info.pb
19:44:16.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.692860 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 19786
19:44:16.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.693571 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-0/wal/instance
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.737650 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:16.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/logs
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data/info.pb
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.66:0
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.66
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.66
19:44:16.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:16.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:16.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:16.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:16.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:16.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:44:16.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.751250 19948 heartbeater.cc:347] Connected to a master server at 127.19.1.125:39715
19:44:16.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.751871 19948 heartbeater.cc:464] Registering TS with master...
19:44:16.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.753623 19948 heartbeater.cc:511] Master 127.19.1.125:39715 requested a full tablet report, sending...
19:44:16.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.754853 19949 heartbeater.cc:347] Connected to a master server at 127.19.1.126:45231
19:44:16.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.755249 19949 heartbeater.cc:464] Registering TS with master...
19:44:16.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.756197 19949 heartbeater.cc:511] Master 127.19.1.126:45231 requested a full tablet report, sending...
19:44:16.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.758172 19599 ts_manager.cc:194] Registered new tserver with Master: b150520519cb496e834a80b39f1c03bd (127.19.1.65:37163)
19:44:16.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.759207 19947 heartbeater.cc:347] Connected to a master server at 127.19.1.124:35639
19:44:16.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.759733 19947 heartbeater.cc:464] Registering TS with master...
19:44:16.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.760035 19512 ts_manager.cc:194] Registered new tserver with Master: b150520519cb496e834a80b39f1c03bd (127.19.1.65:37163)
19:44:16.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.760844 19947 heartbeater.cc:511] Master 127.19.1.124:35639 requested a full tablet report, sending...
19:44:16.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.763554 19688 ts_manager.cc:194] Registered new tserver with Master: b150520519cb496e834a80b39f1c03bd (127.19.1.65:37163)
19:44:16.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:16.767184 19688 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.19.1.65:52063
19:44:17.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.130554 19957 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:17.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.131170 19957 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:17.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.132045 19957 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:17.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.168951 19957 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:17.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.169999 19957 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.19.1.66
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:17.212073 19957 tablet_server_runner.cc:78] Tablet server non-default flags:
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.66:0
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data/info.pb
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.66
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.66
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/logs
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:17.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:17.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:17.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:17.213776 19957 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:17.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:17.216555 19957 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:17.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.246788 19967 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
19:44:17.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:17.773273 19947 heartbeater.cc:503] Master 127.19.1.124:35639 was elected leader, sending a full tablet report...
19:44:18.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.250460 19969 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
19:44:18.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:17.247222 19966 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
19:44:18.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:18.847780 19968 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1599 milliseconds
19:44:18.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.847934 19957 server_base.cc:1029] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
19:44:18.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.849400 19957 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:18.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.852423 19957 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:18.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.853883 19957 hybrid_clock.cc:648] HybridClock initialized: now 1786477458853796 us; error 81 us; skew 500 ppm
19:44:18.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.854970 19957 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:18.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.862398 19957 webserver.cc:460] Webserver started at http://127.19.1.66:45925/ using document root <none> and password file <none>
19:44:18.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.863585 19957 fs_manager.cc:359] Metadata directory not provided
19:44:18.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.864096 19957 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:18.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.864596 19957 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:18.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.870868 19957 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data/instance:
19:44:18.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3c6cef0149854a97965d01b6e0c685e7"
19:44:18.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:18 on dist-test-slave-mvvj"
19:44:18.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.872359 19957 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal/instance:
19:44:18.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3c6cef0149854a97965d01b6e0c685e7"
19:44:18.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:18 on dist-test-slave-mvvj"
19:44:18.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.880759 19957 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.001s
19:44:18.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.887286 19979 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:18.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.888705 19957 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
19:44:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.889063 19957 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal
19:44:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3c6cef0149854a97965d01b6e0c685e7"
19:44:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:18 on dist-test-slave-mvvj"
19:44:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.889405 19957 fs_report.cc:383] FS layout report
19:44:18.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data/data
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:18.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.935791 19957 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:18.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.937386 19957 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:18.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.937860 19957 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:18.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.940557 19957 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
19:44:18.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.945245 19957 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:44:18.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.945472 19957 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:44:18.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.945715 19957 ts_tablet_manager.cc:610] Registered 0 tablets
19:44:18.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:18.945942 19957 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:44:19.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.121793 19957 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.66:38883
19:44:19.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.121944 20109 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.66:38883 every 8 connection(s)
19:44:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.124832 19957 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/data/info.pb
19:44:19.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.129549 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 19957
19:44:19.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.130080 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-1/wal/instance
19:44:19.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.150246 19461 external_mini_cluster.cc:1326] Running /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:19.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu
19:44:19.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal
19:44:19.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/logs
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data/info.pb
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.67:0
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.67
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.67
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:19.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:44:19.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.174224 20110 heartbeater.cc:347] Connected to a master server at 127.19.1.124:35639
19:44:19.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.174769 20110 heartbeater.cc:464] Registering TS with master...
19:44:19.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.175011 20112 heartbeater.cc:347] Connected to a master server at 127.19.1.126:45231
19:44:19.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.175344 20112 heartbeater.cc:464] Registering TS with master...
19:44:19.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.176198 20110 heartbeater.cc:511] Master 127.19.1.124:35639 requested a full tablet report, sending...
19:44:19.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.176398 20112 heartbeater.cc:511] Master 127.19.1.126:45231 requested a full tablet report, sending...
19:44:19.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.179697 19688 ts_manager.cc:194] Registered new tserver with Master: 3c6cef0149854a97965d01b6e0c685e7 (127.19.1.66:38883)
19:44:19.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.180122 20111 heartbeater.cc:347] Connected to a master server at 127.19.1.125:39715
19:44:19.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.180397 19512 ts_manager.cc:194] Registered new tserver with Master: 3c6cef0149854a97965d01b6e0c685e7 (127.19.1.66:38883)
19:44:19.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.180567 20111 heartbeater.cc:464] Registering TS with master...
19:44:19.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.181619 20111 heartbeater.cc:511] Master 127.19.1.125:39715 requested a full tablet report, sending...
19:44:19.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.183373 19688 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.19.1.66:41633
19:44:19.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.184994 19599 ts_manager.cc:194] Registered new tserver with Master: 3c6cef0149854a97965d01b6e0c685e7 (127.19.1.66:38883)
19:44:19.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.540930 20120 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
19:44:19.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.541426 20120 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:44:19.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.541878 20120 flags.cc:425] Enabled unsafe flag: --never_fsync=true
19:44:19.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.575315 20120 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
19:44:19.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.576196 20120 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.19.1.67
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.613024 20120 tablet_server_runner.cc:78] Tablet server non-default flags:
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.19.1.84:46279
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.19.1.67:0
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data/info.pb
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.19.1.67
19:44:19.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.19.1.126:45231,127.19.1.125:39715,127.19.1.124:35639
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.19.1.67
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/logs
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 18:54:03 UTC on ccycloud.quasar-qqxtnc.root.comops.site
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581135
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
19:44:19.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.614351 20120 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:44:19.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.616333 20120 file_cache.cc:493] Constructed file cache file cache with capacity 419430
19:44:19.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.636379 20128 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
19:44:20.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.188485 20110 heartbeater.cc:503] Master 127.19.1.124:35639 was elected leader, sending a full tablet report...
19:44:20.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.636392 20127 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
19:44:20.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:19.636494 20130 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
19:44:20.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:19.639461 20120 server_base.cc:1034] running on GCE node
19:44:20.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.942539 20120 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:44:20.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.945585 20120 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:44:20.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.947140 20120 hybrid_clock.cc:648] HybridClock initialized: now 1786477460947090 us; error 46 us; skew 500 ppm
19:44:20.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.948208 20120 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:44:20.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.956140 20120 webserver.cc:460] Webserver started at http://127.19.1.67:38639/ using document root <none> and password file <none>
19:44:20.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.957499 20120 fs_manager.cc:359] Metadata directory not provided
19:44:20.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.957787 20120 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:44:20.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.958400 20120 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
19:44:20.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.964262 20120 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data/instance:
19:44:20.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e45681509c04803912aed11ee440d7b"
19:44:20.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:20 on dist-test-slave-mvvj"
19:44:20.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.965766 20120 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal/instance:
19:44:20.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e45681509c04803912aed11ee440d7b"
19:44:20.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:20 on dist-test-slave-mvvj"
19:44:20.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.974072 20120 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.005s	sys 0.004s
19:44:20.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.980718 20138 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:44:20.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.982324 20120 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.002s
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.982751 20120 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data,/tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e45681509c04803912aed11ee440d7b"
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 19:44:20 on dist-test-slave-mvvj"
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:20.983162 20120 fs_report.cc:383] FS layout report
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:44:20.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data/data
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:44:20.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:44:21.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.029942 20120 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
19:44:21.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.031615 20120 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:44:21.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.032250 20120 kserver.cc:163] Server-wide thread pool size limit: 3276
19:44:21.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.035369 20120 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
19:44:21.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.040233 20120 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:44:21.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.040575 20120 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:44:21.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.040913 20120 ts_tablet_manager.cc:610] Registered 0 tablets
19:44:21.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.041110 20120 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:44:21.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.217760 20120 rpc_server.cc:307] RPC server started. Bound to: 127.19.1.67:32861
19:44:21.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.217973 20259 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.19.1.67:32861 every 8 connection(s)
19:44:21.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.221176 20120 server_base.cc:1166] Dumped server information to /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/data/info.pb
19:44:21.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.225839 19461 external_mini_cluster.cc:1388] Started /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu as pid 20120
19:44:21.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.226467 19461 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task7bLwl_/test-tmp/mini-kudu-cluster6826836004712948185/ts-2/wal/instance
19:44:21.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.297897 20260 heartbeater.cc:347] Connected to a master server at 127.19.1.124:35639
19:44:21.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.298470 20260 heartbeater.cc:464] Registering TS with master...
19:44:21.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.299299 20261 heartbeater.cc:347] Connected to a master server at 127.19.1.125:39715
19:44:21.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.299687 20261 heartbeater.cc:464] Registering TS with master...
19:44:21.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.299825 20260 heartbeater.cc:511] Master 127.19.1.124:35639 requested a full tablet report, sending...
19:44:21.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.300879 20261 heartbeater.cc:511] Master 127.19.1.125:39715 requested a full tablet report, sending...
19:44:21.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.303076 19688 ts_manager.cc:194] Registered new tserver with Master: 7e45681509c04803912aed11ee440d7b (127.19.1.67:32861)
19:44:21.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.304864 19599 ts_manager.cc:194] Registered new tserver with Master: 7e45681509c04803912aed11ee440d7b (127.19.1.67:32861)
19:44:21.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.305855 19688 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.19.1.67:35065
19:44:21.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.316772 20262 heartbeater.cc:347] Connected to a master server at 127.19.1.126:45231
19:44:21.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.317200 20262 heartbeater.cc:464] Registering TS with master...
19:44:21.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.317986 20262 heartbeater.cc:511] Master 127.19.1.126:45231 requested a full tablet report, sending...
19:44:21.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.320613 19511 ts_manager.cc:194] Registered new tserver with Master: 7e45681509c04803912aed11ee440d7b (127.19.1.67:32861)
19:44:21.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:21.333649 19461 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
19:44:21.348 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
19:44:21.350 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

19:44:21.364 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.19.1.126"
      port: 45231
    }
    bound_http_address {
      host: "127.19.1.126"
      port: 36903
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.19.1.125"
      port: 39715
    }
    bound_http_address {
      host: "127.19.1.125"
      port: 45717
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.19.1.124"
      port: 35639
    }
    bound_http_address {
      host: "127.19.1.124"
      port: 40263
    }
  }
}

19:44:21.370 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

19:44:21.374 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.19.1.65"
      port: 37163
    }
    bound_http_address {
      host: "127.19.1.65"
      port: 45017
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.19.1.66"
      port: 38883
    }
    bound_http_address {
      host: "127.19.1.66"
      port: 45925
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.19.1.67"
      port: 32861
    }
    bound_http_address {
      host: "127.19.1.67"
      port: 38639
    }
  }
}

19:44:21.374 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
19:44:21.574 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
19:44:21.784 [DEBUG - main] (Connection.java:748) [peer master-127.19.1.125:39715(127.19.1.125:39715)] connecting to peer
19:44:21.848 [DEBUG - main] (Connection.java:748) [peer master-127.19.1.126:45231(127.19.1.126:45231)] connecting to peer
19:44:21.851 [DEBUG - main] (Connection.java:748) [peer master-127.19.1.124:35639(127.19.1.124:35639)] connecting to peer
19:44:21.902 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.19.1.125:39715(127.19.1.125:39715)] Successfully connected to peer
19:44:21.910 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.19.1.126:45231(127.19.1.126:45231)] Successfully connected to peer
19:44:21.987 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.19.1.124:35639(127.19.1.124:35639)] Successfully connected to peer
19:44:22.021 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.19.1.126
19:44:22.021 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.19.1.125
19:44:22.144 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.19.1.124
19:44:22.295 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x5dac8d15, L:/127.0.0.1:47602 - R:/127.19.1.126:45231] using SASL/PLAIN
19:44:22.303 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xd8d54e18, L:/127.0.0.1:41118 - R:/127.19.1.125:39715] using SASL/PLAIN
19:44:22.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.312003 20260 heartbeater.cc:503] Master 127.19.1.124:35639 was elected leader, sending a full tablet report...
19:44:22.326 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xa1a05dbc, L:/127.0.0.1:34670 - R:/127.19.1.124:35639] using SASL/PLAIN
19:44:22.373 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
19:44:22.374 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=641), Traces: [0ms] refreshing cache from master, [37ms] Sub RPC ConnectToMaster: sending RPC to server master-127.19.1.125:39715, [110ms] Sub RPC ConnectToMaster: sending RPC to server master-127.19.1.126:45231, [114ms] Sub RPC ConnectToMaster: sending RPC to server master-127.19.1.124:35639, [585ms] Sub RPC ConnectToMaster: received response from server master-127.19.1.125:39715: OK, [585ms] Sub RPC ConnectToMaster: received response from server master-127.19.1.126:45231: OK, [598ms] Sub RPC ConnectToMaster: received response from server master-127.19.1.124:35639: OK, deferred=null) after lookup
19:44:22.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.457358 19688 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:34670:
19:44:22.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786477445455"
19:44:22.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
19:44:22.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
19:44:22.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
19:44:22.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
19:44:22.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:22.460554 19688 catalog_manager.cc:6854] 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-1786477445455 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
19:44:22.530 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table c01a30b0350a4f7693ddac3bd2d12762
19:44:22.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.555969 19872 tablet_service.cc:1467] Processing CreateTablet for tablet 77005981879a4a60a0ab1e147474a857 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786477445455 [id=c01a30b0350a4f7693ddac3bd2d12762]), partition=RANGE (key) PARTITION UNBOUNDED
19:44:22.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.558004 19872 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 77005981879a4a60a0ab1e147474a857. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:22.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.557672 20036 tablet_service.cc:1467] Processing CreateTablet for tablet 77005981879a4a60a0ab1e147474a857 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786477445455 [id=c01a30b0350a4f7693ddac3bd2d12762]), partition=RANGE (key) PARTITION UNBOUNDED
19:44:22.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.559782 20036 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 77005981879a4a60a0ab1e147474a857. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:22.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.566267 20191 tablet_service.cc:1467] Processing CreateTablet for tablet 77005981879a4a60a0ab1e147474a857 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786477445455 [id=c01a30b0350a4f7693ddac3bd2d12762]), partition=RANGE (key) PARTITION UNBOUNDED
19:44:22.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.568434 20191 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 77005981879a4a60a0ab1e147474a857. 1 dirs total, 0 dirs full, 0 dirs failed
19:44:22.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.590060 20298 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Bootstrap starting.
19:44:22.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.594053 20299 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Bootstrap starting.
19:44:22.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.601413 20300 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Bootstrap starting.
19:44:22.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.601821 20298 tablet_bootstrap.cc:654] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Neither blocks nor log segments found. Creating new log.
19:44:22.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.603698 20299 tablet_bootstrap.cc:654] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Neither blocks nor log segments found. Creating new log.
19:44:22.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.604254 20298 log.cc:824] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Log is configured to *not* fsync() on all Append() calls
19:44:22.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.606140 20299 log.cc:824] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Log is configured to *not* fsync() on all Append() calls
19:44:22.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.609465 20300 tablet_bootstrap.cc:654] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Neither blocks nor log segments found. Creating new log.
19:44:22.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.611550 20298 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: No bootstrap required, opened a new log
19:44:22.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.611824 20300 log.cc:824] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Log is configured to *not* fsync() on all Append() calls
19:44:22.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.612149 20298 ts_tablet_manager.cc:1397] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Time spent bootstrapping tablet: real 0.023s	user 0.017s	sys 0.000s
19:44:22.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.620431 20300 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: No bootstrap required, opened a new log
19:44:22.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.620983 20300 ts_tablet_manager.cc:1397] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Time spent bootstrapping tablet: real 0.020s	user 0.017s	sys 0.000s
19:44:22.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.623339 20299 tablet_bootstrap.cc:492] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: No bootstrap required, opened a new log
19:44:22.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.623971 20299 ts_tablet_manager.cc:1397] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Time spent bootstrapping tablet: real 0.031s	user 0.019s	sys 0.009s
19:44:22.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.640322 20298 raft_consensus.cc:348] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.641300 20298 raft_consensus.cc:374] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:22.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.642637 20298 raft_consensus.cc:729] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b150520519cb496e834a80b39f1c03bd, State: Initialized, Role: FOLLOWER
19:44:22.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.643951 20298 consensus_queue.cc:260] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [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: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.648449 20298 ts_tablet_manager.cc:1428] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Time spent starting tablet: real 0.036s	user 0.032s	sys 0.001s
19:44:22.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.656246 20300 raft_consensus.cc:348] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.657260 20300 raft_consensus.cc:374] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.657599 20300 raft_consensus.cc:729] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3c6cef0149854a97965d01b6e0c685e7, State: Initialized, Role: FOLLOWER
19:44:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.658767 20300 consensus_queue.cc:260] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [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: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.670137 20300 ts_tablet_manager.cc:1428] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Time spent starting tablet: real 0.049s	user 0.040s	sys 0.004s
19:44:22.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.672168 20299 raft_consensus.cc:348] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.673671 20299 raft_consensus.cc:374] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:44:22.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.674310 20299 raft_consensus.cc:729] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7e45681509c04803912aed11ee440d7b, State: Initialized, Role: FOLLOWER
19:44:22.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.675812 20299 consensus_queue.cc:260] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [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: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.680434 20299 ts_tablet_manager.cc:1428] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Time spent starting tablet: real 0.056s	user 0.032s	sys 0.011s
19:44:22.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:22.732254 19956 tablet.cc:2369] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:22.768211 20268 tablet.cc:2369] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:22.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.825066 20304 raft_consensus.cc:482] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
19:44:22.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.825686 20304 raft_consensus.cc:504] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.829604 20304 leader_election.cc:288] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3c6cef0149854a97965d01b6e0c685e7 (127.19.1.66:38883), 7e45681509c04803912aed11ee440d7b (127.19.1.67:32861)
19:44:22.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.845698 20061 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "77005981879a4a60a0ab1e147474a857" candidate_uuid: "b150520519cb496e834a80b39f1c03bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3c6cef0149854a97965d01b6e0c685e7" is_pre_election: true
19:44:22.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.845698 20213 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "77005981879a4a60a0ab1e147474a857" candidate_uuid: "b150520519cb496e834a80b39f1c03bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7e45681509c04803912aed11ee440d7b" is_pre_election: true
19:44:22.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.846614 20213 raft_consensus.cc:2454] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b150520519cb496e834a80b39f1c03bd in term 0.
19:44:22.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.846671 20061 raft_consensus.cc:2454] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b150520519cb496e834a80b39f1c03bd in term 0.
19:44:22.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.848116 19820 leader_election.cc:302] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [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: 7e45681509c04803912aed11ee440d7b, b150520519cb496e834a80b39f1c03bd; no voters: 
19:44:22.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.849056 20304 raft_consensus.cc:2781] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Leader pre-election won for term 1
19:44:22.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.849421 20304 raft_consensus.cc:482] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
19:44:22.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.849761 20304 raft_consensus.cc:3037] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 0 FOLLOWER]: Advancing to term 1
19:44:22.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.855003 20304 raft_consensus.cc:504] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.856735 20304 leader_election.cc:288] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [CANDIDATE]: Term 1 election: Requested vote from peers 3c6cef0149854a97965d01b6e0c685e7 (127.19.1.66:38883), 7e45681509c04803912aed11ee440d7b (127.19.1.67:32861)
19:44:22.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.857947 20213 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "77005981879a4a60a0ab1e147474a857" candidate_uuid: "b150520519cb496e834a80b39f1c03bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7e45681509c04803912aed11ee440d7b"
19:44:22.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.857978 20061 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "77005981879a4a60a0ab1e147474a857" candidate_uuid: "b150520519cb496e834a80b39f1c03bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3c6cef0149854a97965d01b6e0c685e7"
19:44:22.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.858580 20061 raft_consensus.cc:3037] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 0 FOLLOWER]: Advancing to term 1
19:44:22.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.858631 20213 raft_consensus.cc:3037] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 0 FOLLOWER]: Advancing to term 1
19:44:22.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.865691 20213 raft_consensus.cc:2454] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b150520519cb496e834a80b39f1c03bd in term 1.
19:44:22.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.865691 20061 raft_consensus.cc:2454] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b150520519cb496e834a80b39f1c03bd in term 1.
19:44:22.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.867290 19820 leader_election.cc:302] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [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: 7e45681509c04803912aed11ee440d7b, b150520519cb496e834a80b39f1c03bd; no voters: 
19:44:22.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.868105 20304 raft_consensus.cc:2781] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 1 FOLLOWER]: Leader election won for term 1
19:44:22.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.870033 20304 raft_consensus.cc:686] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [term 1 LEADER]: Becoming Leader. State: Replica: b150520519cb496e834a80b39f1c03bd, State: Running, Role: LEADER
19:44:22.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.871220 20304 consensus_queue.cc:237] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [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: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } }
19:44:22.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:22.886724 19688 catalog_manager.cc:5495] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd reported cstate change: term changed from 0 to 1, leader changed from <none> to b150520519cb496e834a80b39f1c03bd (127.19.1.65). New cstate: current_term: 1 leader_uuid: "b150520519cb496e834a80b39f1c03bd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b150520519cb496e834a80b39f1c03bd" member_type: VOTER last_known_addr { host: "127.19.1.65" port: 37163 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 } health_report { overall_health: UNKNOWN } } }
19:44:22.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 19:44:22.892860 20115 tablet.cc:2369] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:44:23.082 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 77005981879a4a60a0ab1e147474a857 for table 'org.apache.kudu.client.TestHybridTime-1786477445455' with partition [<start>, <end>)
19:44:23.091 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=77005981879a4a60a0ab1e147474a857@[3c6cef0149854a97965d01b6e0c685e7(127.19.1.66:38883),7e45681509c04803912aed11ee440d7b(127.19.1.67:32861),b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)[L]]}]
19:44:23.092 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=24), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.19.1.124:35639, [11ms] Sub RPC GetTableLocations: received response from server master-127.19.1.124:35639: OK, deferred=null) after lookup
19:44:23.105 [DEBUG - kudu-nio-0] (Connection.java:748) [peer b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)] connecting to peer
19:44:23.107 [DEBUG - kudu-nio-1] (Connection.java:757) [peer b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)] Successfully connected to peer
19:44:23.175 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xf49c0f6e, L:/127.0.0.1:50616 - R:/127.19.1.65:37163] using TOKEN/null
19:44:23.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.190230 20061 raft_consensus.cc:1261] T 77005981879a4a60a0ab1e147474a857 P 3c6cef0149854a97965d01b6e0c685e7 [term 1 FOLLOWER]: Refusing update from remote peer b150520519cb496e834a80b39f1c03bd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:44:23.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.190237 20213 raft_consensus.cc:1261] T 77005981879a4a60a0ab1e147474a857 P 7e45681509c04803912aed11ee440d7b [term 1 FOLLOWER]: Refusing update from remote peer b150520519cb496e834a80b39f1c03bd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:44:23.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.192256 20304 consensus_queue.cc:1035] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [LEADER]: Connected to new peer: Peer: permanent_uuid: "3c6cef0149854a97965d01b6e0c685e7" member_type: VOTER last_known_addr { host: "127.19.1.66" port: 38883 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:44:23.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.193059 20310 consensus_queue.cc:1035] T 77005981879a4a60a0ab1e147474a857 P b150520519cb496e834a80b39f1c03bd [LEADER]: Connected to new peer: Peer: permanent_uuid: "7e45681509c04803912aed11ee440d7b" member_type: VOTER last_known_addr { host: "127.19.1.67" port: 32861 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:44:23.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.218467 20314 mvcc.cc:205] Tried to move back new op lower bound from 7317411689209069568 to 7317411687928623104. Current Snapshot: MvccSnapshot[applied={T|T < 7317411689209069568}]
19:44:23.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.227435 20317 mvcc.cc:205] Tried to move back new op lower bound from 7317411689209069568 to 7317411687928623104. Current Snapshot: MvccSnapshot[applied={T|T < 7317411689209069568}]
19:44:23.371 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.459 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.479 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.483 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@418608437(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:44:23.505 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.505 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1684632918(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:44:23.525 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.526 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@726483802(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:44:23.545 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:44:23.594 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.606 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317411709689069569) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.619 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317411709689069573) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.629 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317411709689069577) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.640 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317411709689069583) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.649 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317411709689069587) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.659 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317411709689069591) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.669 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317411709689069592) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786477445455, tablet=77005981879a4a60a0ab1e147474a857, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:44:23.673 [DEBUG - main] (Connection.java:575) [peer master-127.19.1.124:35639(127.19.1.124:35639)] disconnecting while in state READY
19:44:23.679 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.19.1.124:35639(127.19.1.124:35639)] handling channelInactive
19:44:23.681 [DEBUG - main] (Connection.java:575) [peer master-127.19.1.125:39715(127.19.1.125:39715)] disconnecting while in state READY
19:44:23.681 [DEBUG - main] (Connection.java:575) [peer master-127.19.1.126:45231(127.19.1.126:45231)] disconnecting while in state READY
19:44:23.681 [DEBUG - main] (Connection.java:575) [peer b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)] disconnecting while in state READY
19:44:23.688 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.19.1.126:45231(127.19.1.126:45231)] handling channelInactive
19:44:23.689 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.19.1.124:35639(127.19.1.124:35639)] cleaning up while in state READY due to: connection closed
19:44:23.689 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.19.1.126:45231(127.19.1.126:45231)] cleaning up while in state READY due to: connection closed
19:44:23.690 [DEBUG - kudu-nio-1] (Connection.java:239) [peer b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)] handling channelInactive
19:44:23.690 [DEBUG - kudu-nio-1] (Connection.java:709) [peer b150520519cb496e834a80b39f1c03bd(127.19.1.65:37163)] cleaning up while in state READY due to: connection closed
19:44:23.691 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
19:44:23.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.693331 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 19786
19:44:23.695 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.19.1.125:39715(127.19.1.125:39715)] handling channelInactive
19:44:23.695 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.19.1.125:39715(127.19.1.125:39715)] cleaning up while in state READY due to: connection closed
19:44:23.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.736696 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 19957
19:44:23.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.775264 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 20120
19:44:23.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.810494 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 19473
19:44:23.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.851469 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 19554
19:44:23.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 19:44:23.883668 19461 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task7bLwl_/build/tsan/bin/kudu with pid 19639
19:44:25.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T19:44:25Z chronyd exiting

Time: 20.939

OK (1 test)

