JUnit version 4.13.2
.16:11:07.294 [INFO - main] (RandomUtils.java:49) Using random seed: 1786464667287
16:11:07.316 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
16:11:07.386 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
16:11:07.396 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskJy10i3/test-tmp
16:11:07.399 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
16:11:07.403 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskJy10i3/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
16:11:07.641 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

16:11:07.819 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:11:07.820 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

16:11:07.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.824658 22030 mini_oidc.cc:152] Starting JWKS server
16:11:07.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.828552 22030 webserver.cc:460] Webserver started at http://127.0.0.1:39535/ using document root <none> and password file <none>
16:11:07.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.829232 22030 mini_oidc.cc:189] Starting OIDC Discovery server
16:11:07.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.831545 22030 webserver.cc:460] Webserver started at http://127.0.0.1:35465/ using document root <none> and password file <none>
16:11:07.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:07Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:11:07.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:07Z Disabled control of system clock
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:07.890560 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:07.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/logs
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data/info.pb
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:07.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:11:07.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.190:37407
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.190
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:07.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:07.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:07.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:07.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:07.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:07.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json with env {}
16:11:08.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.225386 22047 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:08.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.226105 22047 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:08.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.226657 22047 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:08.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.258893 22047 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:11:08.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.259325 22047 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:08.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.259735 22047 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:11:08.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.260226 22047 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:11:08.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.260783 22047 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:11:08.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.261168 22047 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39535/jwks.json
16:11:08.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.298916 22047 master_runner.cc:386] Master server non-default flags:
16:11:08.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:08.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:08.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:08.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:08.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data
16:11:08.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.190:37407
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:08.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data/info.pb
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.190
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:08.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/logs
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:08.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:08.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:08.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:08.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.300781 22047 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:08.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.303388 22047 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:09.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.324828 22064 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
16:11:09.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.324842 22060 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
16:11:09.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:08.325595 22047 server_base.cc:1034] running on GCE node
16:11:09.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:08.324851 22068 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
16:11:09.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.469548 22047 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:09.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.473718 22047 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:09.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.475296 22047 hybrid_clock.cc:648] HybridClock initialized: now 1786464669475269 us; error 115 us; skew 500 ppm
16:11:09.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.476341 22047 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:09.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.484004 22047 webserver.cc:460] Webserver started at http://127.21.131.190:32807/ using document root <none> and password file <none>
16:11:09.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.485212 22047 fs_manager.cc:359] Metadata directory not provided
16:11:09.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.485441 22047 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:09.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.485882 22047 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:09.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.491449 22047 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data/instance:
16:11:09.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a2060db7ffaf48c7873c45032ba10468"
16:11:09.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:09 on dist-test-slave-lgr5"
16:11:09.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.492869 22047 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal/instance:
16:11:09.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a2060db7ffaf48c7873c45032ba10468"
16:11:09.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:09 on dist-test-slave-lgr5"
16:11:09.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.501668 22047 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.007s	sys 0.001s
16:11:09.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.508457 22077 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:09.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.509768 22047 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.001s
16:11:09.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.510138 22047 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal
16:11:09.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a2060db7ffaf48c7873c45032ba10468"
16:11:09.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:09 on dist-test-slave-lgr5"
16:11:09.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.510581 22047 fs_report.cc:383] FS layout report
16:11:09.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:09.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data/data
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:09.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:09.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:09.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.548838 22047 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:09.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.550592 22047 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
16:11:09.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.551102 22047 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:09.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.630656 22047 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.190:37407
16:11:09.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.630878 22180 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.190:37407 every 8 connection(s)
16:11:09.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.634100 22047 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/data/info.pb
16:11:09.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.637265 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 22047
16:11:09.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.637881 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-0/wal/instance
16:11:09.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.641098 22181 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:09.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.642149 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:09.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:09.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/logs
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data/info.pb
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:09.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:09.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.189:41953
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.189
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:09.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:09.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:09.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json with env {}
16:11:09.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.655030 22181 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } has no permanent_uuid. Determining permanent_uuid...
16:11:09.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.694181 22181 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } has no permanent_uuid. Determining permanent_uuid...
16:11:09.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:09.697312 22083 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:09.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:09.702320 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:09.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.752005 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 1
16:11:09.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:09.757380 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:09.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.825881 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 2
16:11:09.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:09.830618 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:09.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:09.922093 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 3
16:11:09.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:09.927150 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:10.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.013566 22185 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:10.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.014322 22185 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:10.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.015137 22185 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:10.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.048345 22185 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:11:10.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.048738 22185 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:10.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.049057 22185 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:11:10.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.049401 22185 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:11:10.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.049759 22185 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:11:10.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.049985 22185 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39535/jwks.json
16:11:10.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.070602 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 4
16:11:10.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.074859 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.089418 22185 master_runner.cc:386] Master server non-default flags:
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal
16:11:10.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.189:41953
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:10.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data/info.pb
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.189
16:11:10.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:10.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/logs
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:10.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:10.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:10.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:10.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.091421 22185 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:10.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.094380 22185 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:10.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.115759 22203 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
16:11:10.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.374327 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 5
16:11:10.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.378294 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:10.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.925971 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 6
16:11:10.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.934865 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.189:41953: Network error: Client connection negotiation failed: client connection to 127.21.131.189:41953: connect: Connection refused (error 111)
16:11:11.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.116014 22204 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
16:11:11.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:10.118557 22185 server_base.cc:1034] running on GCE node
16:11:11.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:10.116008 22208 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
16:11:11.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.255746 22185 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.258888 22185 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.260370 22185 hybrid_clock.cc:648] HybridClock initialized: now 1786464671260310 us; error 60 us; skew 500 ppm
16:11:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.261565 22185 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:11.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.269667 22185 webserver.cc:460] Webserver started at http://127.21.131.189:46051/ using document root <none> and password file <none>
16:11:11.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.271246 22185 fs_manager.cc:359] Metadata directory not provided
16:11:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.271616 22185 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.272583 22185 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.278980 22185 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data/instance:
16:11:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "703cd93d75d3425cb0f9eb9b60ebdab7"
16:11:11.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:11 on dist-test-slave-lgr5"
16:11:11.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.281200 22185 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal/instance:
16:11:11.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "703cd93d75d3425cb0f9eb9b60ebdab7"
16:11:11.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:11 on dist-test-slave-lgr5"
16:11:11.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.290377 22185 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.009s	sys 0.000s
16:11:11.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.297912 22223 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:11.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.299302 22185 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.005s	sys 0.000s
16:11:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.299722 22185 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal
16:11:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "703cd93d75d3425cb0f9eb9b60ebdab7"
16:11:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:11 on dist-test-slave-lgr5"
16:11:11.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.300289 22185 fs_report.cc:383] FS layout report
16:11:11.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:11.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal
16:11:11.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data/data
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:11.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:11.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.352586 22185 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:11.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.354434 22185 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
16:11:11.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.355032 22185 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.431699 22185 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.189:41953
16:11:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.431810 22310 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.189:41953 every 8 connection(s)
16:11:11.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.434907 22185 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/data/info.pb
16:11:11.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.441322 22311 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:11.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.441519 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 22185
16:11:11.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.441867 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-1/wal/instance
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.443977 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:11.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/logs
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data/info.pb
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:11:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.188:34657
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.188
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json with env {}
16:11:11.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.458264 22311 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } has no permanent_uuid. Determining permanent_uuid...
16:11:11.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.486743 22311 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } has no permanent_uuid. Determining permanent_uuid...
16:11:11.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.507524 22311 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } has no permanent_uuid. Determining permanent_uuid...
16:11:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.510380 22227 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.515007 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.564728 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 1
16:11:11.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.569056 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.637552 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 2
16:11:11.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.642207 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.733728 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 3
16:11:11.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.737826 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.800289 22316 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:11.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.800942 22316 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:11.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.801546 22316 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:11.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.834658 22316 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:11:11.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.834967 22316 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:11.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.835186 22316 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:11:11.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.835368 22316 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:11:11.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.835594 22316 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:11:11.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.835736 22316 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39535/jwks.json
16:11:11.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.875931 22316 master_runner.cc:386] Master server non-default flags:
16:11:11.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.188:34657
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39535/jwks.json
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data/info.pb
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.188
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:11.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/logs
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:11.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:11.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:11.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:11.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.877802 22316 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:11.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.880179 22316 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:11.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.881385 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 4
16:11:11.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.886727 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:11.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.902796 22336 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
16:11:11.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.995388 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } attempt: 7
16:11:12.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.013882 22181 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } has no permanent_uuid. Determining permanent_uuid...
16:11:12.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.020004 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.078488 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 1
16:11:12.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.083817 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.165330 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 2
16:11:12.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.170050 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.186292 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 5
16:11:12.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.191623 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.255535 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 3
16:11:12.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.260665 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.401154 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 4
16:11:12.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.406286 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.689754 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 5
16:11:12.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.694661 22181 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:12.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:12.739203 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 6
16:11:12.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:12.747030 22311 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.21.131.188:34657: Network error: Client connection negotiation failed: client connection to 127.21.131.188:34657: connect: Connection refused (error 111)
16:11:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.903143 22337 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
16:11:13.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:11.903909 22341 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
16:11:13.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:11.904943 22316 server_base.cc:1034] running on GCE node
16:11:13.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.046868 22316 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:13.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.049801 22316 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:13.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.051257 22316 hybrid_clock.cc:648] HybridClock initialized: now 1786464673051218 us; error 45 us; skew 500 ppm
16:11:13.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.052414 22316 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:13.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.059846 22316 webserver.cc:460] Webserver started at http://127.21.131.188:33549/ using document root <none> and password file <none>
16:11:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.061172 22316 fs_manager.cc:359] Metadata directory not provided
16:11:13.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.061429 22316 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:13.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.062086 22316 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:13.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.067833 22316 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data/instance:
16:11:13.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44f8bacde4784263b1b0ec2f5a422ff9"
16:11:13.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:13 on dist-test-slave-lgr5"
16:11:13.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.069620 22316 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal/instance:
16:11:13.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44f8bacde4784263b1b0ec2f5a422ff9"
16:11:13.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:13 on dist-test-slave-lgr5"
16:11:13.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.078953 22316 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.009s	sys 0.000s
16:11:13.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.085743 22359 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:13.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.087168 22316 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.002s
16:11:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.087601 22316 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal
16:11:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44f8bacde4784263b1b0ec2f5a422ff9"
16:11:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:13 on dist-test-slave-lgr5"
16:11:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.088047 22316 fs_report.cc:383] FS layout report
16:11:13.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data/data
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:13.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:13.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.130355 22316 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:13.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.132316 22316 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
16:11:13.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.132910 22316 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.208330 22316 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.188:34657
16:11:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.208452 22464 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.188:34657 every 8 connection(s)
16:11:13.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.211331 22316 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/data/info.pb
16:11:13.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.217422 22465 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:13.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.218545 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 22316
16:11:13.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.218943 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/master-2/wal/instance
16:11:13.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.238826 22465 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } has no permanent_uuid. Determining permanent_uuid...
16:11:13.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.247066 22181 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 6
16:11:13.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.276958 22465 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } has no permanent_uuid. Determining permanent_uuid...
16:11:13.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.291169 22181 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: Bootstrap starting.
16:11:13.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.291560 22465 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } has no permanent_uuid. Determining permanent_uuid...
16:11:13.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.298792 22181 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: Neither blocks nor log segments found. Creating new log.
16:11:13.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.301139 22181 log.cc:824] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: Log is configured to *not* fsync() on all Append() calls
16:11:13.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.308786 22181 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: No bootstrap required, opened a new log
16:11:13.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.314847 22465 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: Bootstrap starting.
16:11:13.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.322562 22465 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: Neither blocks nor log segments found. Creating new log.
16:11:13.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.325407 22465 log.cc:824] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: Log is configured to *not* fsync() on all Append() calls
16:11:13.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.331424 22465 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: No bootstrap required, opened a new log
16:11:13.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.335345 22181 raft_consensus.cc:348] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.336176 22181 raft_consensus.cc:374] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:13.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.336490 22181 raft_consensus.cc:729] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a2060db7ffaf48c7873c45032ba10468, State: Initialized, Role: FOLLOWER
16:11:13.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.337489 22181 consensus_queue.cc:260] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.341197 22483 sys_catalog.cc:455] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:13.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.342717 22483 sys_catalog.cc:458] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: This master's current role is: FOLLOWER
16:11:13.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.343369 22181 sys_catalog.cc:564] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: configured and running, proceeding with master startup.
16:11:13.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.360037 22465 raft_consensus.cc:348] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.361095 22465 raft_consensus.cc:374] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:13.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.361408 22465 raft_consensus.cc:729] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 44f8bacde4784263b1b0ec2f5a422ff9, State: Initialized, Role: FOLLOWER
16:11:13.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.362439 22465 consensus_queue.cc:260] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.365713 22513 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:13.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.367034 22513 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: This master's current role is: FOLLOWER
16:11:13.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.367775 22465 sys_catalog.cc:564] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: configured and running, proceeding with master startup.
16:11:13.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.380195 22514 catalog_manager.cc:1558] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:11:13.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.381011 22514 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:11:13.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.388779 22374 tablet.cc:2369] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:11:13.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.378785 22047 master_runner.cc:186] Error getting master registration for 127.21.131.189:41953: OK, instance_id { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" instance_seqno: 1786464671411313 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:11:13.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.418304 22047 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:11:13.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.423568 22535 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:11:13.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.424458 22535 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:11:13.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.419476 22316 master_runner.cc:186] Error getting master registration for 127.21.131.189:41953: OK, instance_id { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" instance_seqno: 1786464671411313 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:11:13.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.459900 22316 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:11:13.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:13.561852 22085 tablet.cc:2369] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:11:13.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.766685 22483 raft_consensus.cc:482] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:11:13.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.767303 22483 raft_consensus.cc:504] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.773818 22427 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a2060db7ffaf48c7873c45032ba10468" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" is_pre_election: true
16:11:13.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.774866 22427 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a2060db7ffaf48c7873c45032ba10468 in term 0.
16:11:13.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.776481 22081 leader_election.cc:302] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [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: 44f8bacde4784263b1b0ec2f5a422ff9, a2060db7ffaf48c7873c45032ba10468; no voters: 
16:11:13.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.778409 22537 raft_consensus.cc:2781] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:11:13.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.778273 22483 leader_election.cc:288] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 703cd93d75d3425cb0f9eb9b60ebdab7 (127.21.131.189:41953), 44f8bacde4784263b1b0ec2f5a422ff9 (127.21.131.188:34657)
16:11:13.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.779191 22537 raft_consensus.cc:482] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:11:13.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.779810 22537 raft_consensus.cc:3037] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 0 FOLLOWER]: Advancing to term 1
16:11:13.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.787458 22537 raft_consensus.cc:504] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.790099 22537 leader_election.cc:288] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [CANDIDATE]: Term 1 election: Requested vote from peers 703cd93d75d3425cb0f9eb9b60ebdab7 (127.21.131.189:41953), 44f8bacde4784263b1b0ec2f5a422ff9 (127.21.131.188:34657)
16:11:13.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.792611 22427 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a2060db7ffaf48c7873c45032ba10468" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "44f8bacde4784263b1b0ec2f5a422ff9"
16:11:13.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.793239 22427 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 0 FOLLOWER]: Advancing to term 1
16:11:13.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.800485 22427 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a2060db7ffaf48c7873c45032ba10468 in term 1.
16:11:13.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.801822 22081 leader_election.cc:302] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [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: 44f8bacde4784263b1b0ec2f5a422ff9, a2060db7ffaf48c7873c45032ba10468; no voters: 
16:11:13.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.802946 22537 raft_consensus.cc:2781] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 1 FOLLOWER]: Leader election won for term 1
16:11:13.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.807433 22311 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } attempt: 7
16:11:13.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.805065 22537 raft_consensus.cc:686] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [term 1 LEADER]: Becoming Leader. State: Replica: a2060db7ffaf48c7873c45032ba10468, State: Running, Role: LEADER
16:11:13.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.826519 22537 consensus_queue.cc:237] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.851042 22483 sys_catalog.cc:455] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a2060db7ffaf48c7873c45032ba10468. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:13.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.852409 22483 sys_catalog.cc:458] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: This master's current role is: LEADER
16:11:13.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.868435 22548 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
16:11:13.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.875038 22311 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: Bootstrap starting.
16:11:13.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.880303 22548 catalog_manager.cc:1484] Initializing Kudu cluster ID...
16:11:13.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.894025 22311 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: Neither blocks nor log segments found. Creating new log.
16:11:13.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.900467 22311 log.cc:824] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: Log is configured to *not* fsync() on all Append() calls
16:11:13.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.924238 22427 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [term 1 FOLLOWER]: Refusing update from remote peer a2060db7ffaf48c7873c45032ba10468: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:11:13.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.928192 22483 consensus_queue.cc:1035] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [LEADER]: Connected to new peer: Peer: permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
16:11:13.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.930328 22311 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: No bootstrap required, opened a new log
16:11:13.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.979585 22311 raft_consensus.cc:348] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.980760 22311 raft_consensus.cc:374] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:13.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.981086 22311 raft_consensus.cc:729] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 703cd93d75d3425cb0f9eb9b60ebdab7, State: Initialized, Role: FOLLOWER
16:11:13.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.982095 22311 consensus_queue.cc:260] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } }
16:11:13.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.990615 22556 sys_catalog.cc:455] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [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: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:13.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.991573 22556 sys_catalog.cc:458] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: This master's current role is: FOLLOWER
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.994711 22311 sys_catalog.cc:564] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: configured and running, proceeding with master startup.
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.994889 22265 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a2060db7ffaf48c7873c45032ba10468" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" is_pre_election: true
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.995920 22265 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a2060db7ffaf48c7873c45032ba10468 in term 0.
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.997023 22262 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a2060db7ffaf48c7873c45032ba10468" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7"
16:11:14.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:13.997690 22262 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 0 FOLLOWER]: Advancing to term 1
16:11:14.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.007258 22262 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a2060db7ffaf48c7873c45032ba10468 in term 1.
16:11:14.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.009078 22261 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [term 1 FOLLOWER]: Refusing update from remote peer a2060db7ffaf48c7873c45032ba10468: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:11:14.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.018373 22483 consensus_queue.cc:1035] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [LEADER]: Connected to new peer: Peer: permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
16:11:14.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.056417 22550 mvcc.cc:205] Tried to move back new op lower bound from 7317359304368320512 to 7317359304030056448. Current Snapshot: MvccSnapshot[applied={T|T < 7317359304368320512}]
16:11:14.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.058861 22554 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a2060db7ffaf48c7873c45032ba10468. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.060071 22554 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: This master's current role is: FOLLOWER
16:11:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.075269 22556 sys_catalog.cc:455] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a2060db7ffaf48c7873c45032ba10468. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.076169 22556 sys_catalog.cc:458] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: This master's current role is: FOLLOWER
16:11:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.076591 22548 catalog_manager.cc:1347] Generated new cluster ID: d503d69e1716466cbaaead78a6a0042c
16:11:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.076890 22548 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
16:11:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.079492 22565 mvcc.cc:205] Tried to move back new op lower bound from 7317359304368320512 to 7317359304030056448. Current Snapshot: MvccSnapshot[applied={T|T < 7317359304368320512}]
16:11:14.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.080291 22554 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.081097 22554 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9 [sys.catalog]: This master's current role is: FOLLOWER
16:11:14.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.084962 22537 sys_catalog.cc:455] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.085736 22537 sys_catalog.cc:458] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: This master's current role is: LEADER
16:11:14.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.092281 22556 sys_catalog.cc:455] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.093055 22556 sys_catalog.cc:458] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7 [sys.catalog]: This master's current role is: FOLLOWER
16:11:14.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.094497 22537 sys_catalog.cc:455] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a2060db7ffaf48c7873c45032ba10468" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a2060db7ffaf48c7873c45032ba10468" member_type: VOTER last_known_addr { host: "127.21.131.190" port: 37407 } } peers { permanent_uuid: "703cd93d75d3425cb0f9eb9b60ebdab7" member_type: VOTER last_known_addr { host: "127.21.131.189" port: 41953 } } peers { permanent_uuid: "44f8bacde4784263b1b0ec2f5a422ff9" member_type: VOTER last_known_addr { host: "127.21.131.188" port: 34657 } } }
16:11:14.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.095283 22537 sys_catalog.cc:458] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468 [sys.catalog]: This master's current role is: LEADER
16:11:14.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.118889 22587 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
16:11:14.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.123721 22548 catalog_manager.cc:1370] Generated new certificate authority record
16:11:14.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.126642 22548 catalog_manager.cc:1504] Loading token signing keys...
16:11:14.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.162778 22548 catalog_manager.cc:5868] T 00000000000000000000000000000000 P a2060db7ffaf48c7873c45032ba10468: Generated new TSK 0
16:11:14.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.165092 22548 catalog_manager.cc:1514] Initializing in-progress tserver states...
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.194029 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:14.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/logs
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data/info.pb
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.129:0
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.129
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.129
16:11:14.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:14.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:14.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:14.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:14.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:14.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:11:14.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.434000 22535 catalog_manager.cc:1259] Loaded cluster ID: d503d69e1716466cbaaead78a6a0042c
16:11:14.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.434726 22535 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: loading cluster ID for follower catalog manager: success
16:11:14.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.444494 22535 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: acquiring CA information for follower catalog manager: success
16:11:14.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.451761 22535 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 44f8bacde4784263b1b0ec2f5a422ff9: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:11:14.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.736929 22589 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:14.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.737684 22589 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:14.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.738440 22589 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:14.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.794718 22589 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:14.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.796269 22589 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.131.129
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.858835 22589 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:14.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.129:0
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data/info.pb
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.129
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.129
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/logs
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:14.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:14.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.860651 22589 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:14.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:14.863400 22589 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:14.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.892638 22599 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
16:11:15.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.128880 22587 catalog_manager.cc:1259] Loaded cluster ID: d503d69e1716466cbaaead78a6a0042c
16:11:15.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.129604 22587 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: loading cluster ID for follower catalog manager: success
16:11:15.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.151348 22587 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: acquiring CA information for follower catalog manager: success
16:11:15.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:15.187223 22587 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 703cd93d75d3425cb0f9eb9b60ebdab7: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:11:17.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:16.283237 22598 debug-util.cc:398] Leaking SignalData structure 0x7b0800014860 after lost signal to thread 22589
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.460306 22598 kernel_stack_watchdog.cc:198] Thread 22589 stuck at /data0/somelongdirectorytoavoidrpathissues/src/kudu/src/kudu/util/thread.cc:637 for 391ms:
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.460620 22589 thread.cc:636] OpenStack (cloud detector) Time spent creating pthread: real 2.571s	user 0.703s	sys 1.249s
16:11:17.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.461012 22589 thread.cc:602] OpenStack (cloud detector) Time spent starting thread: real 2.572s	user 0.703s	sys 1.249s
16:11:17.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.463358 22606 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
16:11:17.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:17.463744 22607 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
16:11:17.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:14.895385 22602 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
16:11:17.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.465427 22589 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
16:11:17.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.469354 22589 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:17.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.472265 22589 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:17.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.473711 22589 hybrid_clock.cc:648] HybridClock initialized: now 1786464677473629 us; error 98 us; skew 500 ppm
16:11:17.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.474798 22589 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:17.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.488400 22589 webserver.cc:460] Webserver started at http://127.21.131.129:34425/ using document root <none> and password file <none>
16:11:17.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.489624 22589 fs_manager.cc:359] Metadata directory not provided
16:11:17.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.489879 22589 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:17.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.490444 22589 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:17.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.496228 22589 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data/instance:
16:11:17.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec3051c4eebb4235865b6a975f463276"
16:11:17.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-lgr5"
16:11:17.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.498044 22589 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal/instance:
16:11:17.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec3051c4eebb4235865b6a975f463276"
16:11:17.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-lgr5"
16:11:17.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.509265 22589 fs_manager.cc:691] Time spent creating directory manager: real 0.010s	user 0.005s	sys 0.005s
16:11:17.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.516352 22619 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:17.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.517868 22589 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.001s
16:11:17.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.518292 22589 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal
16:11:17.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ec3051c4eebb4235865b6a975f463276"
16:11:17.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:17 on dist-test-slave-lgr5"
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.518728 22589 fs_report.cc:383] FS layout report
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data/data
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:17.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:17.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.566974 22589 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:17.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.568888 22589 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
16:11:17.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.569482 22589 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:17.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.572868 22589 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:17.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.578145 22589 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:17.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.578378 22589 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:17.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.578599 22589 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:17.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.578722 22589 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:17.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.798610 22589 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.129:36015
16:11:17.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.798750 22834 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.129:36015 every 8 connection(s)
16:11:17.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.801783 22589 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/data/info.pb
16:11:17.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.808053 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 22589
16:11:17.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.808935 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-0/wal/instance
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.830806 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:17.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/logs
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data/info.pb
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.130:0
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.130
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.130
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:17.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:17.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:17.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:17.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:17.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:11:17.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.938004 22835 heartbeater.cc:347] Connected to a master server at 127.21.131.188:34657
16:11:17.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.938628 22835 heartbeater.cc:464] Registering TS with master...
16:11:17.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.940099 22835 heartbeater.cc:511] Master 127.21.131.188:34657 requested a full tablet report, sending...
16:11:17.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.942427 22843 heartbeater.cc:347] Connected to a master server at 127.21.131.190:37407
16:11:17.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.942860 22843 heartbeater.cc:464] Registering TS with master...
16:11:17.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.943869 22843 heartbeater.cc:511] Master 127.21.131.190:37407 requested a full tablet report, sending...
16:11:17.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.944275 22391 ts_manager.cc:194] Registered new tserver with Master: ec3051c4eebb4235865b6a975f463276 (127.21.131.129:36015)
16:11:17.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.947350 22104 ts_manager.cc:194] Registered new tserver with Master: ec3051c4eebb4235865b6a975f463276 (127.21.131.129:36015)
16:11:17.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.950676 22836 heartbeater.cc:347] Connected to a master server at 127.21.131.189:41953
16:11:17.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.951134 22836 heartbeater.cc:464] Registering TS with master...
16:11:17.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.952044 22836 heartbeater.cc:511] Master 127.21.131.189:41953 requested a full tablet report, sending...
16:11:17.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.955581 22104 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.21.131.129:50725
16:11:17.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:17.955732 22252 ts_manager.cc:194] Registered new tserver with Master: ec3051c4eebb4235865b6a975f463276 (127.21.131.129:36015)
16:11:18.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.250710 22845 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:18.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.251350 22845 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:18.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.252012 22845 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:18.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.286342 22845 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:18.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.287431 22845 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.131.130
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.325845 22845 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:18.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data
16:11:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal
16:11:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.130:0
16:11:18.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data/info.pb
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.130
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:18.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.130
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/logs
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:18.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.327514 22845 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:18.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.330164 22845 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:18.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.357579 22864 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
16:11:18.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:18.962302 22843 heartbeater.cc:503] Master 127.21.131.190:37407 was elected leader, sending a full tablet report...
16:11:19.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.357599 22863 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
16:11:19.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:18.358822 22869 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
16:11:19.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:19.485282 22865 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
16:11:19.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.485404 22845 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
16:11:19.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.490003 22845 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:19.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.493072 22845 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:19.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.494621 22845 hybrid_clock.cc:648] HybridClock initialized: now 1786464679494574 us; error 60 us; skew 500 ppm
16:11:19.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.495766 22845 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:19.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.503758 22845 webserver.cc:460] Webserver started at http://127.21.131.130:38039/ using document root <none> and password file <none>
16:11:19.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.504922 22845 fs_manager.cc:359] Metadata directory not provided
16:11:19.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.505144 22845 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:19.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.505574 22845 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:19.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.511422 22845 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data/instance:
16:11:19.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4f595b0672014aa2907cb96849ed8e1d"
16:11:19.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:19 on dist-test-slave-lgr5"
16:11:19.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.513123 22845 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal/instance:
16:11:19.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4f595b0672014aa2907cb96849ed8e1d"
16:11:19.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:19 on dist-test-slave-lgr5"
16:11:19.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.521215 22845 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.003s	sys 0.005s
16:11:19.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.527737 22880 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:19.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.529033 22845 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
16:11:19.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.529443 22845 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4f595b0672014aa2907cb96849ed8e1d"
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:19 on dist-test-slave-lgr5"
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.529932 22845 fs_report.cc:383] FS layout report
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data/data
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:19.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.572876 22845 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:19.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.574605 22845 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
16:11:19.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.575194 22845 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:19.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.578095 22845 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:19.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.582870 22845 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:19.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.583127 22845 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:19.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.583408 22845 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:19.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.583616 22845 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:19.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.770685 22845 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.130:43831
16:11:19.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.770798 23093 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.130:43831 every 8 connection(s)
16:11:19.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.773530 22845 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/data/info.pb
16:11:19.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.781355 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 22845
16:11:19.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.781884 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-1/wal/instance
16:11:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.820199 22030 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu
16:11:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/logs
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data/info.pb
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.131:0
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.131
16:11:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.131
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:11:19.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.858579 23094 heartbeater.cc:347] Connected to a master server at 127.21.131.188:34657
16:11:19.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.859175 23094 heartbeater.cc:464] Registering TS with master...
16:11:19.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.860478 23094 heartbeater.cc:511] Master 127.21.131.188:34657 requested a full tablet report, sending...
16:11:19.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.861792 23098 heartbeater.cc:347] Connected to a master server at 127.21.131.190:37407
16:11:19.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.862170 23098 heartbeater.cc:464] Registering TS with master...
16:11:19.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.862984 23098 heartbeater.cc:511] Master 127.21.131.190:37407 requested a full tablet report, sending...
16:11:19.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.864002 22391 ts_manager.cc:194] Registered new tserver with Master: 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831)
16:11:19.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.864856 23096 heartbeater.cc:347] Connected to a master server at 127.21.131.189:41953
16:11:19.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.865209 23096 heartbeater.cc:464] Registering TS with master...
16:11:19.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.865926 22104 ts_manager.cc:194] Registered new tserver with Master: 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831)
16:11:19.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.866333 23096 heartbeater.cc:511] Master 127.21.131.189:41953 requested a full tablet report, sending...
16:11:19.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.868218 22104 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.21.131.130:49977
16:11:19.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:19.871789 22252 ts_manager.cc:194] Registered new tserver with Master: 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831)
16:11:20.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.198071 23111 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:11:20.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.198763 23111 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:11:20.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.199536 23111 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:11:20.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.240276 23111 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:11:20.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.241252 23111 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.131.131
16:11:20.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.280146 23111 tablet_server_runner.cc:78] Tablet server non-default flags:
16:11:20.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:11:20.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.131.148:32941
16:11:20.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:11:20.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.131.131:0
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data/info.pb
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.131.131
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.131.190:37407,127.21.131.189:41953,127.21.131.188:34657
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.131.131
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/logs
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:12:52 UTC on ccycloud.quasar-tzrfpd.root.comops.site
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580143
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:11:20.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.281595 23111 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:11:20.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.283425 23111 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:11:20.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.305668 23133 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
16:11:20.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.873889 23098 heartbeater.cc:503] Master 127.21.131.190:37407 was elected leader, sending a full tablet report...
16:11:21.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.305696 23136 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
16:11:21.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:20.307871 23111 server_base.cc:1034] running on GCE node
16:11:21.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:20.305958 23132 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
16:11:21.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.506713 23111 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:11:21.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.510419 23111 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:11:21.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.511948 23111 hybrid_clock.cc:648] HybridClock initialized: now 1786464681511909 us; error 45 us; skew 500 ppm
16:11:21.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.513041 23111 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:11:21.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.528426 23111 webserver.cc:460] Webserver started at http://127.21.131.131:44113/ using document root <none> and password file <none>
16:11:21.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.529660 23111 fs_manager.cc:359] Metadata directory not provided
16:11:21.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.529937 23111 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:11:21.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.530570 23111 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:11:21.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.537299 23111 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data/instance:
16:11:21.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "569de63b0d894410a1aad847e2573232"
16:11:21.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:21 on dist-test-slave-lgr5"
16:11:21.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.538765 23111 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal/instance:
16:11:21.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "569de63b0d894410a1aad847e2573232"
16:11:21.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:21 on dist-test-slave-lgr5"
16:11:21.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.552016 23111 fs_manager.cc:691] Time spent creating directory manager: real 0.012s	user 0.005s	sys 0.008s
16:11:21.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.563020 23148 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:11:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.564872 23111 fs_manager.cc:725] Time spent opening block manager: real 0.008s	user 0.002s	sys 0.004s
16:11:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.565342 23111 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data,/tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal
16:11:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "569de63b0d894410a1aad847e2573232"
16:11:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:11:21 on dist-test-slave-lgr5"
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.565811 23111 fs_report.cc:383] FS layout report
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data/data
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:11:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:11:21.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.629433 23111 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:11:21.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.632423 23111 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
16:11:21.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.633272 23111 kserver.cc:163] Server-wide thread pool size limit: 3276
16:11:21.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.640538 23111 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:11:21.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.650528 23111 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:11:21.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.650853 23111 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:11:21.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.651363 23111 ts_tablet_manager.cc:610] Registered 0 tablets
16:11:21.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.651569 23111 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:11:21.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.974181 23111 rpc_server.cc:307] RPC server started. Bound to: 127.21.131.131:37183
16:11:21.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.974334 23376 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.131.131:37183 every 8 connection(s)
16:11:21.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.978519 23111 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/data/info.pb
16:11:21.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.983551 22030 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu as pid 23111
16:11:21.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:21.983935 22030 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskJy10i3/test-tmp/mini-kudu-cluster3222606711888052130/ts-2/wal/instance
16:11:22.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.078625 23389 heartbeater.cc:347] Connected to a master server at 127.21.131.190:37407
16:11:22.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.079226 23389 heartbeater.cc:464] Registering TS with master...
16:11:22.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.080704 23389 heartbeater.cc:511] Master 127.21.131.190:37407 requested a full tablet report, sending...
16:11:22.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.080971 23383 heartbeater.cc:347] Connected to a master server at 127.21.131.189:41953
16:11:22.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.081189 23381 heartbeater.cc:347] Connected to a master server at 127.21.131.188:34657
16:11:22.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.081583 23383 heartbeater.cc:464] Registering TS with master...
16:11:22.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.081643 23381 heartbeater.cc:464] Registering TS with master...
16:11:22.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.083698 23381 heartbeater.cc:511] Master 127.21.131.188:34657 requested a full tablet report, sending...
16:11:22.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.083814 23383 heartbeater.cc:511] Master 127.21.131.189:41953 requested a full tablet report, sending...
16:11:22.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.084770 22104 ts_manager.cc:194] Registered new tserver with Master: 569de63b0d894410a1aad847e2573232 (127.21.131.131:37183)
16:11:22.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.087352 22104 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.21.131.131:48057
16:11:22.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.087677 22252 ts_manager.cc:194] Registered new tserver with Master: 569de63b0d894410a1aad847e2573232 (127.21.131.131:37183)
16:11:22.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.090380 22391 ts_manager.cc:194] Registered new tserver with Master: 569de63b0d894410a1aad847e2573232 (127.21.131.131:37183)
16:11:22.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:22.105319 22030 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
16:11:22.121 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:11:22.123 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

16:11:22.139 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.131.190"
      port: 37407
    }
    bound_http_address {
      host: "127.21.131.190"
      port: 32807
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.131.189"
      port: 41953
    }
    bound_http_address {
      host: "127.21.131.189"
      port: 46051
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.131.188"
      port: 34657
    }
    bound_http_address {
      host: "127.21.131.188"
      port: 33549
    }
  }
}

16:11:22.144 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

16:11:22.147 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.131.129"
      port: 36015
    }
    bound_http_address {
      host: "127.21.131.129"
      port: 34425
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.131.130"
      port: 43831
    }
    bound_http_address {
      host: "127.21.131.130"
      port: 38039
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.131.131"
      port: 37183
    }
    bound_http_address {
      host: "127.21.131.131"
      port: 44113
    }
  }
}

16:11:22.147 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
16:11:22.377 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
16:11:22.612 [DEBUG - main] (Connection.java:748) [peer master-127.21.131.190:37407(127.21.131.190:37407)] connecting to peer
16:11:22.679 [DEBUG - main] (Connection.java:748) [peer master-127.21.131.189:41953(127.21.131.189:41953)] connecting to peer
16:11:22.682 [DEBUG - main] (Connection.java:748) [peer master-127.21.131.188:34657(127.21.131.188:34657)] connecting to peer
16:11:22.718 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.21.131.189:41953(127.21.131.189:41953)] Successfully connected to peer
16:11:22.722 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.21.131.190:37407(127.21.131.190:37407)] Successfully connected to peer
16:11:22.817 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.21.131.188:34657(127.21.131.188:34657)] Successfully connected to peer
16:11:22.854 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.131.190
16:11:22.854 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.131.189
16:11:22.993 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.131.188
16:11:23.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.093283 23389 heartbeater.cc:503] Master 127.21.131.190:37407 was elected leader, sending a full tablet report...
16:11:23.146 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x05c3bf46, L:/127.0.0.1:42832 - R:/127.21.131.189:41953] using SASL/PLAIN
16:11:23.146 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xe46c3657, L:/127.0.0.1:41690 - R:/127.21.131.190:37407] using SASL/PLAIN
16:11:23.153 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x7bcda434, L:/127.0.0.1:40706 - R:/127.21.131.188:34657] using SASL/PLAIN
16:11:23.198 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
16:11:23.200 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=636), Traces: [0ms] refreshing cache from master, [35ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.131.190:37407, [110ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.131.189:41953, [112ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.131.188:34657, [596ms] Sub RPC ConnectToMaster: received response from server master-127.21.131.189:41953: OK, [598ms] Sub RPC ConnectToMaster: received response from server master-127.21.131.190:37407: OK, deferred=null) after lookup
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.275899 22104 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:41690:
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786464667192"
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:11:23.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:11:23.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:23.282336 22104 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-1786464667192 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
16:11:23.392 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table cdbd61c9e75c41b6b184de693ebec8d6
16:11:23.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.442294 22701 tablet_service.cc:1467] Processing CreateTablet for tablet ecf1ed56fc694946a7a97144ddb8b96d (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464667192 [id=cdbd61c9e75c41b6b184de693ebec8d6]), partition=RANGE (key) PARTITION UNBOUNDED
16:11:23.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.445232 22701 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet ecf1ed56fc694946a7a97144ddb8b96d. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:23.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.451042 23242 tablet_service.cc:1467] Processing CreateTablet for tablet ecf1ed56fc694946a7a97144ddb8b96d (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464667192 [id=cdbd61c9e75c41b6b184de693ebec8d6]), partition=RANGE (key) PARTITION UNBOUNDED
16:11:23.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.454438 23242 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet ecf1ed56fc694946a7a97144ddb8b96d. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:23.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.452699 22964 tablet_service.cc:1467] Processing CreateTablet for tablet ecf1ed56fc694946a7a97144ddb8b96d (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464667192 [id=cdbd61c9e75c41b6b184de693ebec8d6]), partition=RANGE (key) PARTITION UNBOUNDED
16:11:23.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.456487 22964 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet ecf1ed56fc694946a7a97144ddb8b96d. 1 dirs total, 0 dirs full, 0 dirs failed
16:11:23.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.516202 23455 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Bootstrap starting.
16:11:23.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.516896 23458 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Bootstrap starting.
16:11:23.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.533671 23459 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Bootstrap starting.
16:11:23.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.534912 23458 tablet_bootstrap.cc:654] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Neither blocks nor log segments found. Creating new log.
16:11:23.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.536841 23455 tablet_bootstrap.cc:654] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Neither blocks nor log segments found. Creating new log.
16:11:23.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.541180 23458 log.cc:824] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Log is configured to *not* fsync() on all Append() calls
16:11:23.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.542217 23455 log.cc:824] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Log is configured to *not* fsync() on all Append() calls
16:11:23.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.551713 23455 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: No bootstrap required, opened a new log
16:11:23.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.552222 23459 tablet_bootstrap.cc:654] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Neither blocks nor log segments found. Creating new log.
16:11:23.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.552728 23455 ts_tablet_manager.cc:1397] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Time spent bootstrapping tablet: real 0.046s	user 0.014s	sys 0.019s
16:11:23.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.556918 23459 log.cc:824] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Log is configured to *not* fsync() on all Append() calls
16:11:23.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.557641 23458 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: No bootstrap required, opened a new log
16:11:23.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.558525 23458 ts_tablet_manager.cc:1397] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Time spent bootstrapping tablet: real 0.043s	user 0.026s	sys 0.012s
16:11:23.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.569662 23459 tablet_bootstrap.cc:492] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: No bootstrap required, opened a new log
16:11:23.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.570696 23459 ts_tablet_manager.cc:1397] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Time spent bootstrapping tablet: real 0.039s	user 0.013s	sys 0.020s
16:11:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.602077 23455 raft_consensus.cc:348] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.603154 23455 raft_consensus.cc:374] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:23.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.603541 23455 raft_consensus.cc:729] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ec3051c4eebb4235865b6a975f463276, State: Initialized, Role: FOLLOWER
16:11:23.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.606712 23455 consensus_queue.cc:260] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [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: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.615381 23455 ts_tablet_manager.cc:1428] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Time spent starting tablet: real 0.062s	user 0.032s	sys 0.028s
16:11:23.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.616777 23458 raft_consensus.cc:348] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.630798 23458 raft_consensus.cc:374] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:23.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.631239 23458 raft_consensus.cc:729] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 569de63b0d894410a1aad847e2573232, State: Initialized, Role: FOLLOWER
16:11:23.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.631035 23459 raft_consensus.cc:348] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.633307 23459 raft_consensus.cc:374] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:11:23.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.632611 23458 consensus_queue.cc:260] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [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: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.633970 23459 raft_consensus.cc:729] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4f595b0672014aa2907cb96849ed8e1d, State: Initialized, Role: FOLLOWER
16:11:23.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.635736 23459 consensus_queue.cc:260] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [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: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.647816 23459 ts_tablet_manager.cc:1428] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Time spent starting tablet: real 0.077s	user 0.041s	sys 0.024s
16:11:23.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.655349 23458 ts_tablet_manager.cc:1428] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Time spent starting tablet: real 0.096s	user 0.040s	sys 0.043s
16:11:23.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:23.691181 22844 tablet.cc:2369] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:11:23.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.777397 23465 raft_consensus.cc:482] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:11:23.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.778049 23465 raft_consensus.cc:504] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.781638 23465 leader_election.cc:288] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 569de63b0d894410a1aad847e2573232 (127.21.131.131:37183), 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831)
16:11:23.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:23.787539 23396 tablet.cc:2369] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:11:23.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.802345 23469 raft_consensus.cc:482] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:11:23.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.803130 23469 raft_consensus.cc:504] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.811117 23469 leader_election.cc:288] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831), ec3051c4eebb4235865b6a975f463276 (127.21.131.129:36015)
16:11:23.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:11:23.831827 23104 tablet.cc:2369] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:11:23.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.832168 23282 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "ec3051c4eebb4235865b6a975f463276" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "569de63b0d894410a1aad847e2573232" is_pre_election: true
16:11:23.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.833518 23282 raft_consensus.cc:2454] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ec3051c4eebb4235865b6a975f463276 in term 0.
16:11:23.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.841409 22621 leader_election.cc:302] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [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: 569de63b0d894410a1aad847e2573232, ec3051c4eebb4235865b6a975f463276; no voters: 
16:11:23.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.843289 23465 raft_consensus.cc:2781] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:11:23.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.843868 23465 raft_consensus.cc:482] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:11:23.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.844494 23465 raft_consensus.cc:3037] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 0 FOLLOWER]: Advancing to term 1
16:11:23.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.859179 23013 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "ec3051c4eebb4235865b6a975f463276" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4f595b0672014aa2907cb96849ed8e1d" is_pre_election: true
16:11:23.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.860502 23013 raft_consensus.cc:2454] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ec3051c4eebb4235865b6a975f463276 in term 0.
16:11:23.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.862087 23010 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "569de63b0d894410a1aad847e2573232" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4f595b0672014aa2907cb96849ed8e1d" is_pre_election: true
16:11:23.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.862987 23010 raft_consensus.cc:2454] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 569de63b0d894410a1aad847e2573232 in term 0.
16:11:23.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.863385 22737 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "569de63b0d894410a1aad847e2573232" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ec3051c4eebb4235865b6a975f463276" is_pre_election: true
16:11:23.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.863693 23465 raft_consensus.cc:504] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.864727 23149 leader_election.cc:302] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [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: 4f595b0672014aa2907cb96849ed8e1d, 569de63b0d894410a1aad847e2573232; no voters: 
16:11:23.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.865495 22737 raft_consensus.cc:2379] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 1 FOLLOWER]: Leader pre-election vote request: Denying vote to candidate 569de63b0d894410a1aad847e2573232 in current term 1: Already voted for candidate ec3051c4eebb4235865b6a975f463276 in this term.
16:11:23.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.865795 23469 raft_consensus.cc:2781] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:11:23.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.866173 23469 raft_consensus.cc:482] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:11:23.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.866487 23469 raft_consensus.cc:3037] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 0 FOLLOWER]: Advancing to term 1
16:11:23.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.867250 23282 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "ec3051c4eebb4235865b6a975f463276" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "569de63b0d894410a1aad847e2573232"
16:11:23.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.867697 23465 leader_election.cc:288] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [CANDIDATE]: Term 1 election: Requested vote from peers 569de63b0d894410a1aad847e2573232 (127.21.131.131:37183), 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831)
16:11:23.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.868434 23010 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "ec3051c4eebb4235865b6a975f463276" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4f595b0672014aa2907cb96849ed8e1d"
16:11:23.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.868907 23010 raft_consensus.cc:3037] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 0 FOLLOWER]: Advancing to term 1
16:11:23.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.872861 23469 raft_consensus.cc:504] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.874296 23282 raft_consensus.cc:2379] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate ec3051c4eebb4235865b6a975f463276 in current term 1: Already voted for candidate 569de63b0d894410a1aad847e2573232 in this term.
16:11:23.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.874205 23010 raft_consensus.cc:2454] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ec3051c4eebb4235865b6a975f463276 in term 1.
16:11:23.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.875195 23469 leader_election.cc:288] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [CANDIDATE]: Term 1 election: Requested vote from peers 4f595b0672014aa2907cb96849ed8e1d (127.21.131.130:43831), ec3051c4eebb4235865b6a975f463276 (127.21.131.129:36015)
16:11:23.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.875646 22621 leader_election.cc:302] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [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: 4f595b0672014aa2907cb96849ed8e1d, ec3051c4eebb4235865b6a975f463276; no voters: 
16:11:23.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.876739 23465 raft_consensus.cc:2781] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 1 FOLLOWER]: Leader election won for term 1
16:11:23.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.876958 23013 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "569de63b0d894410a1aad847e2573232" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "4f595b0672014aa2907cb96849ed8e1d"
16:11:23.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.876997 22737 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "ecf1ed56fc694946a7a97144ddb8b96d" candidate_uuid: "569de63b0d894410a1aad847e2573232" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ec3051c4eebb4235865b6a975f463276"
16:11:23.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.877817 23013 raft_consensus.cc:2379] T ecf1ed56fc694946a7a97144ddb8b96d P 4f595b0672014aa2907cb96849ed8e1d [term 1 FOLLOWER]: Leader election vote request: Denying vote to candidate 569de63b0d894410a1aad847e2573232 in current term 1: Already voted for candidate ec3051c4eebb4235865b6a975f463276 in this term.
16:11:23.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.881386 23465 raft_consensus.cc:686] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [term 1 LEADER]: Becoming Leader. State: Replica: ec3051c4eebb4235865b6a975f463276, State: Running, Role: LEADER
16:11:23.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.882865 23465 consensus_queue.cc:237] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [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: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } }
16:11:23.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.907850 23151 leader_election.cc:302] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [CANDIDATE]: Term 1 election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: 569de63b0d894410a1aad847e2573232; no voters: 4f595b0672014aa2907cb96849ed8e1d, ec3051c4eebb4235865b6a975f463276
16:11:23.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.910185 23469 raft_consensus.cc:2726] T ecf1ed56fc694946a7a97144ddb8b96d P 569de63b0d894410a1aad847e2573232 [term 1 FOLLOWER]: Leader election lost for term 1. Reason: could not achieve majority
16:11:23.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:23.914179 22105 catalog_manager.cc:5495] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 reported cstate change: term changed from 0 to 1, leader changed from <none> to ec3051c4eebb4235865b6a975f463276 (127.21.131.129). New cstate: current_term: 1 leader_uuid: "ec3051c4eebb4235865b6a975f463276" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "ec3051c4eebb4235865b6a975f463276" member_type: VOTER last_known_addr { host: "127.21.131.129" port: 36015 } health_report { overall_health: HEALTHY } } }
16:11:24.320 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet ecf1ed56fc694946a7a97144ddb8b96d for table 'org.apache.kudu.client.TestHybridTime-1786464667192' with partition [<start>, <end>)
16:11:24.330 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=ecf1ed56fc694946a7a97144ddb8b96d@[4f595b0672014aa2907cb96849ed8e1d(127.21.131.130:43831),569de63b0d894410a1aad847e2573232(127.21.131.131:37183),ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)[L]]}]
16:11:24.332 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=29), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.21.131.190:37407, [14ms] Sub RPC GetTableLocations: received response from server master-127.21.131.190:37407: OK, deferred=null) after lookup
16:11:24.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:24.343300 23465 consensus_queue.cc:1035] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [LEADER]: Connected to new peer: Peer: permanent_uuid: "4f595b0672014aa2907cb96849ed8e1d" member_type: VOTER last_known_addr { host: "127.21.131.130" port: 43831 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
16:11:24.349 [DEBUG - kudu-nio-0] (Connection.java:748) [peer ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)] connecting to peer
16:11:24.354 [DEBUG - kudu-nio-1] (Connection.java:757) [peer ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)] Successfully connected to peer
16:11:24.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:24.424204 23465 consensus_queue.cc:1035] T ecf1ed56fc694946a7a97144ddb8b96d P ec3051c4eebb4235865b6a975f463276 [LEADER]: Connected to new peer: Peer: permanent_uuid: "569de63b0d894410a1aad847e2573232" member_type: VOTER last_known_addr { host: "127.21.131.131" port: 37183 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
16:11:24.479 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x8236f5d8, L:/127.0.0.1:47732 - R:/127.21.131.129:36015] using TOKEN/null
16:11:24.601 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.638 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.670 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.682 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1885914995(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:11:24.717 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.718 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@589218535(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:11:24.736 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.736 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1424991933(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:11:24.755 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:11:24.831 [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-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.851 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317359368162643969) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.867 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317359368162643973) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.881 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317359368162643977) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.892 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317359368162643983) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.903 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317359368162643987) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.914 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317359368162643991) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.928 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317359368162643992) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464667192, tablet=ecf1ed56fc694946a7a97144ddb8b96d, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:11:24.932 [DEBUG - main] (Connection.java:575) [peer ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)] disconnecting while in state READY
16:11:24.934 [DEBUG - main] (Connection.java:575) [peer master-127.21.131.189:41953(127.21.131.189:41953)] disconnecting while in state READY
16:11:24.934 [DEBUG - main] (Connection.java:575) [peer master-127.21.131.190:37407(127.21.131.190:37407)] disconnecting while in state READY
16:11:24.934 [DEBUG - main] (Connection.java:575) [peer master-127.21.131.188:34657(127.21.131.188:34657)] disconnecting while in state READY
16:11:24.944 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:11:24.946 [DEBUG - kudu-nio-1] (Connection.java:239) [peer ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)] handling channelInactive
16:11:24.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:24.946269 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 22589
16:11:24.953 [DEBUG - kudu-nio-1] (Connection.java:709) [peer ec3051c4eebb4235865b6a975f463276(127.21.131.129:36015)] cleaning up while in state READY due to: connection closed
16:11:24.954 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.21.131.189:41953(127.21.131.189:41953)] handling channelInactive
16:11:24.954 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.21.131.189:41953(127.21.131.189:41953)] cleaning up while in state READY due to: connection closed
16:11:24.957 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.21.131.190:37407(127.21.131.190:37407)] handling channelInactive
16:11:24.958 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.21.131.190:37407(127.21.131.190:37407)] cleaning up while in state READY due to: connection closed
16:11:24.958 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.21.131.188:34657(127.21.131.188:34657)] handling channelInactive
16:11:24.958 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.21.131.188:34657(127.21.131.188:34657)] cleaning up while in state READY due to: connection closed
16:11:25.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:25.004653 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 22845
16:11:25.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:25.036432 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 23111
16:11:25.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:25.091590 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 22047
16:11:25.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:25.131757 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 22185
16:11:25.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:11:25.167084 22030 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskJy10i3/build/tsan/bin/kudu with pid 22316
16:11:26.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:11:26Z chronyd exiting

Time: 20.328

OK (1 test)

