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

16:15:30.845 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:15:30.846 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

16:15:30.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.849874  4483 mini_oidc.cc:152] Starting JWKS server
16:15:30.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.853577  4483 webserver.cc:460] Webserver started at http://127.0.0.1:46829/ using document root <none> and password file <none>
16:15:30.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.854110  4483 mini_oidc.cc:189] Starting OIDC Discovery server
16:15:30.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.856211  4483 webserver.cc:460] Webserver started at http://127.0.0.1:39513/ using document root <none> and password file <none>
16:15:30.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:30Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:15:30.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:30Z Disabled control of system clock
16:15:30.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.908927  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:30.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:30.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal
16:15:30.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data
16:15:30.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/logs
16:15:30.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data/info.pb
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:30.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.254:35939
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.254
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:30.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:30.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json with env {}
16:15:31.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.216957  4497 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:31.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.217572  4497 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:31.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.218369  4497 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:31.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.251030  4497 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:31.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.251354  4497 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:31.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.251577  4497 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:31.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.251761  4497 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:31.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.251937  4497 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:31.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.252104  4497 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46829/jwks.json
16:15:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.288789  4497 master_runner.cc:386] Master server non-default flags:
16:15:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:31.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.254:35939
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data/info.pb
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.254
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:31.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/logs
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:31.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:31.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.290053  4497 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:15:31.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.292378  4497 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:31.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.312165  4515 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:15:32.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.312175  4511 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:15:32.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.312403  4513 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:15:32.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.313597  4497 server_base.cc:1034] running on GCE node
16:15:32.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.432233  4497 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:32.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.434933  4497 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:32.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.436304  4497 hybrid_clock.cc:648] HybridClock initialized: now 1786464932436276 us; error 47 us; skew 500 ppm
16:15:32.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.437184  4497 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:32.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.443773  4497 webserver.cc:460] Webserver started at http://127.4.96.254:44047/ using document root <none> and password file <none>
16:15:32.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.444726  4497 fs_manager.cc:359] Metadata directory not provided
16:15:32.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.444928  4497 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:32.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.445339  4497 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:32.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.450371  4497 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data/instance:
16:15:32.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd5ab6e1c1d0479dbe78378bbf21b740"
16:15:32.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-jpj1"
16:15:32.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.451519  4497 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal/instance:
16:15:32.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd5ab6e1c1d0479dbe78378bbf21b740"
16:15:32.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-jpj1"
16:15:32.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.459973  4497 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.001s	sys 0.006s
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.466475  4527 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.467777  4497 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.001s
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.468138  4497 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal
16:15:32.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd5ab6e1c1d0479dbe78378bbf21b740"
16:15:32.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-jpj1"
16:15:32.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.468554  4497 fs_report.cc:383] FS layout report
16:15:32.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:32.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal
16:15:32.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal
16:15:32.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data/data
16:15:32.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:32.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:32.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.510082  4497 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:32.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.511933  4497 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:15:32.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.512446  4497 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:32.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.589977  4497 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.254:35939
16:15:32.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.590073  4598 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.254:35939 every 8 connection(s)
16:15:32.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.592891  4497 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/data/info.pb
16:15:32.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.597481  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 4497
16:15:32.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.598044  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-0/wal/instance
16:15:32.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.599278  4599 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:15:32.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.603175  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:32.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:32.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal
16:15:32.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data
16:15:32.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/logs
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data/info.pb
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:32.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.253:44651
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.253
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:32.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:32.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json with env {}
16:15:32.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.613865  4599 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } has no permanent_uuid. Determining permanent_uuid...
16:15:32.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.645262  4599 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } has no permanent_uuid. Determining permanent_uuid...
16:15:32.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.647945  4531 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:32.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.652155  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:32.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.701664  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 1
16:15:32.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.705866  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:32.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.774277  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 2
16:15:32.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.778398  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:32.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.869831  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 3
16:15:32.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.876111  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:32.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.920158  4605 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:32.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.920892  4605 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:32.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.921743  4605 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:32.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.957693  4605 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:32.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.958061  4605 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:32.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.958372  4605 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:32.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.958696  4605 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:32.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.959020  4605 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:32.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.959250  4605 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46829/jwks.json
16:15:32.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.994974  4605 master_runner.cc:386] Master server non-default flags:
16:15:32.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:32.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.253:44651
16:15:32.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data/info.pb
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.253
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:32.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:32.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/logs
16:15:32.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:32.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:32.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:32.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.996615  4605 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:15:32.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.998973  4605 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:33.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.016511  4623 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:15:33.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.019563  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 4
16:15:33.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.023422  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:33.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.322904  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 5
16:15:33.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.327135  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:33.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.874560  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 6
16:15:33.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.882074  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.253:44651: Network error: Client connection negotiation failed: client connection to 127.4.96.253:44651: connect: Connection refused (error 111)
16:15:34.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.016535  4627 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:15:34.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.016726  4621 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:15:34.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.018275  4605 server_base.cc:1034] running on GCE node
16:15:34.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.134302  4605 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:34.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.137234  4605 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:34.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.138648  4605 hybrid_clock.cc:648] HybridClock initialized: now 1786464934138615 us; error 42 us; skew 500 ppm
16:15:34.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.139649  4605 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:34.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.145967  4605 webserver.cc:460] Webserver started at http://127.4.96.253:41365/ using document root <none> and password file <none>
16:15:34.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.147063  4605 fs_manager.cc:359] Metadata directory not provided
16:15:34.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.147284  4605 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:34.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.147876  4605 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.152837  4605 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data/instance:
16:15:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a14412800a764224b19e7142ef0de183"
16:15:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-jpj1"
16:15:34.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.154174  4605 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal/instance:
16:15:34.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a14412800a764224b19e7142ef0de183"
16:15:34.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-jpj1"
16:15:34.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.161743  4605 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.004s
16:15:34.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.167518  4637 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:34.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.168710  4605 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
16:15:34.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.169057  4605 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal
16:15:34.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a14412800a764224b19e7142ef0de183"
16:15:34.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-jpj1"
16:15:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.169453  4605 fs_report.cc:383] FS layout report
16:15:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal
16:15:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal
16:15:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data/data
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:34.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:34.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.228593  4605 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:34.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.230340  4605 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:15:34.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.230881  4605 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:34.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.305137  4605 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.253:44651
16:15:34.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.305243  4712 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.253:44651 every 8 connection(s)
16:15:34.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.308153  4605 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/data/info.pb
16:15:34.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.310360  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 4605
16:15:34.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.310842  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-1/wal/instance
16:15:34.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.313406  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/logs
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data/info.pb
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:34.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.252:37247
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.252
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json with env {}
16:15:34.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.314765  4717 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:15:34.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.328213  4717 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.353029  4717 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.370714  4717 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.373057  4642 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.377288  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.426808  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 1
16:15:34.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.430868  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.499249  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 2
16:15:34.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.503588  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.595052  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 3
16:15:34.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.599884  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.634850  4720 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:34.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.635439  4720 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:34.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.635972  4720 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.666970  4720 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.667255  4720 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.667445  4720 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:34.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.667672  4720 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:34.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.667882  4720 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:34.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.668030  4720 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46829/jwks.json
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.703737  4720 master_runner.cc:386] Master server non-default flags:
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.252:37247
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46829/jwks.json
16:15:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data/info.pb
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.252
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/logs
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:34.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:34.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:34.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.704979  4720 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:15:34.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.706732  4720 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:34.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.723739  4745 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:15:34.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.743350  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 4
16:15:34.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.747141  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:34.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.942631  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } attempt: 7
16:15:34.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.969419  4599 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.974459  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.032991  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 1
16:15:35.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.037705  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.046662  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 5
16:15:35.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.050729  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.119148  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 2
16:15:35.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.124660  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.210081  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 3
16:15:35.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.214308  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.354749  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 4
16:15:35.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.359251  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.598276  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 6
16:15:35.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.604790  4717 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.642656  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 5
16:15:35.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.646402  4599 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.96.252:37247: Network error: Client connection negotiation failed: client connection to 127.4.96.252:37247: connect: Connection refused (error 111)
16:15:35.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.723730  4739 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:15:35.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.725502  4720 server_base.cc:1034] running on GCE node
16:15:35.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.723803  4741 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:15:35.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.843369  4720 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:35.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.846086  4720 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:35.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.847467  4720 hybrid_clock.cc:648] HybridClock initialized: now 1786464935847418 us; error 69 us; skew 500 ppm
16:15:35.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.848402  4720 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:35.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.854916  4720 webserver.cc:460] Webserver started at http://127.4.96.252:39849/ using document root <none> and password file <none>
16:15:35.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.855919  4720 fs_manager.cc:359] Metadata directory not provided
16:15:35.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.856119  4720 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:35.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.856632  4720 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:35.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.861930  4720 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data/instance:
16:15:35.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dc4c3c6f714643f1811d70c2dfa4fc73"
16:15:35.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-jpj1"
16:15:35.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.863101  4720 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal/instance:
16:15:35.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dc4c3c6f714643f1811d70c2dfa4fc73"
16:15:35.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-jpj1"
16:15:35.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.871877  4720 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.007s	sys 0.001s
16:15:35.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.877756  4762 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:35.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.878955  4720 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
16:15:35.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.879314  4720 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dc4c3c6f714643f1811d70c2dfa4fc73"
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-jpj1"
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.879805  4720 fs_report.cc:383] FS layout report
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data/data
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:35.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:35.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:35.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:35.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:35.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:35.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:35.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.921257  4720 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:35.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.922973  4720 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:15:35.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.923477  4720 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:35.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.995744  4720 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.252:37247
16:15:35.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.995841  4842 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.252:37247 every 8 connection(s)
16:15:35.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.998555  4720 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/data/info.pb
16:15:36.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.000067  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 4720
16:15:36.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.000497  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/master-2/wal/instance
16:15:36.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.004926  4844 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:15:36.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.022905  4844 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } has no permanent_uuid. Determining permanent_uuid...
16:15:36.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.050992  4844 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } has no permanent_uuid. Determining permanent_uuid...
16:15:36.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.062144  4844 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } has no permanent_uuid. Determining permanent_uuid...
16:15:36.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.079670  4844 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: Bootstrap starting.
16:15:36.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.085646  4844 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: Neither blocks nor log segments found. Creating new log.
16:15:36.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.087926  4844 log.cc:824] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: Log is configured to *not* fsync() on all Append() calls
16:15:36.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.092964  4844 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: No bootstrap required, opened a new log
16:15:36.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.114758  4844 raft_consensus.cc:348] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.115413  4844 raft_consensus.cc:374] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.115675  4844 raft_consensus.cc:729] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: dc4c3c6f714643f1811d70c2dfa4fc73, State: Initialized, Role: FOLLOWER
16:15:36.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.116467  4844 consensus_queue.cc:260] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.120813  4856 sys_catalog.cc:455] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.121734  4856 sys_catalog.cc:458] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.122800  4844 sys_catalog.cc:564] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.166958  4871 catalog_manager.cc:1558] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:15:36.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.167722  4871 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:15:36.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.178838  4771 tablet.cc:2369] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:36.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.165858  4720 master_runner.cc:186] Error getting master registration for 127.4.96.254:35939: OK, instance_id { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" instance_seqno: 1786464932569853 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:15:36.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.194730  4720 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:15:36.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.201435  4599 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 6
16:15:36.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.219857  4599 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: Bootstrap starting.
16:15:36.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.225569  4599 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: Neither blocks nor log segments found. Creating new log.
16:15:36.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.227469  4599 log.cc:824] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: Log is configured to *not* fsync() on all Append() calls
16:15:36.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.231997  4599 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: No bootstrap required, opened a new log
16:15:36.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.254515  4599 raft_consensus.cc:348] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.255854  4599 raft_consensus.cc:374] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.256456  4599 raft_consensus.cc:729] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bd5ab6e1c1d0479dbe78378bbf21b740, State: Initialized, Role: FOLLOWER
16:15:36.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.257582  4599 consensus_queue.cc:260] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.260610  4879 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.261482  4879 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.262431  4599 sys_catalog.cc:564] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.272858  4536 tablet.cc:2369] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:36.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.293277  4898 catalog_manager.cc:1558] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:15:36.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.293967  4898 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:15:36.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.296063  4879 raft_consensus.cc:482] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:15:36.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.296573  4879 raft_consensus.cc:504] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.303278  4879 leader_election.cc:288] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers a14412800a764224b19e7142ef0de183 (127.4.96.253:44651), dc4c3c6f714643f1811d70c2dfa4fc73 (127.4.96.252:37247)
16:15:36.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.305801  4806 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" is_pre_election: true
16:15:36.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.307005  4806 raft_consensus.cc:2454] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate bd5ab6e1c1d0479dbe78378bbf21b740 in term 0.
16:15:36.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.308389  4531 leader_election.cc:302] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [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: bd5ab6e1c1d0479dbe78378bbf21b740, dc4c3c6f714643f1811d70c2dfa4fc73; no voters: 
16:15:36.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.309960  4879 raft_consensus.cc:2781] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:15:36.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.310334  4879 raft_consensus.cc:482] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:15:36.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.310637  4879 raft_consensus.cc:3037] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.317427  4879 raft_consensus.cc:504] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.322651  4806 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73"
16:15:36.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.323258  4806 raft_consensus.cc:3037] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.325528  4879 leader_election.cc:288] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [CANDIDATE]: Term 1 election: Requested vote from peers a14412800a764224b19e7142ef0de183 (127.4.96.253:44651), dc4c3c6f714643f1811d70c2dfa4fc73 (127.4.96.252:37247)
16:15:36.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.292943  4497 master_runner.cc:186] Error getting master registration for 127.4.96.253:44651: OK, instance_id { permanent_uuid: "a14412800a764224b19e7142ef0de183" instance_seqno: 1786464934284139 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:15:36.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.328609  4497 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:15:36.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.329814  4806 raft_consensus.cc:2454] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bd5ab6e1c1d0479dbe78378bbf21b740 in term 1.
16:15:36.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.330821  4531 leader_election.cc:302] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [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: bd5ab6e1c1d0479dbe78378bbf21b740, dc4c3c6f714643f1811d70c2dfa4fc73; no voters: 
16:15:36.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.331856  4879 raft_consensus.cc:2781] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 1 FOLLOWER]: Leader election won for term 1
16:15:36.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.344743  4879 raft_consensus.cc:686] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [term 1 LEADER]: Becoming Leader. State: Replica: bd5ab6e1c1d0479dbe78378bbf21b740, State: Running, Role: LEADER
16:15:36.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.345767  4879 consensus_queue.cc:237] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.355211  4900 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd5ab6e1c1d0479dbe78378bbf21b740. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.356096  4900 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: This master's current role is: LEADER
16:15:36.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.361135  4902 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
16:15:36.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.370362  4902 catalog_manager.cc:1484] Initializing Kudu cluster ID...
16:15:36.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.394824  4806 raft_consensus.cc:1261] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [term 1 FOLLOWER]: Refusing update from remote peer bd5ab6e1c1d0479dbe78378bbf21b740: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:36.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.398820  4879 consensus_queue.cc:1035] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [LEADER]: Connected to new peer: Peer: permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
16:15:36.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.429602  4905 mvcc.cc:205] Tried to move back new op lower bound from 7317360379451203584 to 7317360379282825216. Current Snapshot: MvccSnapshot[applied={T|T < 7317360379451203584}]
16:15:36.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.431917  4900 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.432672  4900 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: This master's current role is: LEADER
16:15:36.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.432289  4856 sys_catalog.cc:455] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd5ab6e1c1d0479dbe78378bbf21b740. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.433027  4856 sys_catalog.cc:458] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.440470  4902 catalog_manager.cc:1347] Generated new cluster ID: 7e44a55228284cc8ae94cd214d1fad72
16:15:36.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.440793  4902 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
16:15:36.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.443069  4856 sys_catalog.cc:455] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.443843  4856 sys_catalog.cc:458] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.479830  4902 catalog_manager.cc:1370] Generated new certificate authority record
16:15:36.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.484671  4902 catalog_manager.cc:1504] Loading token signing keys...
16:15:36.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.510656  4902 catalog_manager.cc:5868] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740: Generated new TSK 0
16:15:36.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.514278  4902 catalog_manager.cc:1514] Initializing in-progress tserver states...
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.535597  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/logs
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data/info.pb
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.193:0
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.193
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.193
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:36.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:36.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.665282  4717 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } attempt: 7
16:15:36.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.716527  4717 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: Bootstrap starting.
16:15:36.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.736948  4717 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: Neither blocks nor log segments found. Creating new log.
16:15:36.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.743721  4717 log.cc:824] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: Log is configured to *not* fsync() on all Append() calls
16:15:36.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.768006  4717 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: No bootstrap required, opened a new log
16:15:36.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.850349  4717 raft_consensus.cc:348] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.853406  4717 raft_consensus.cc:374] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.854481  4717 raft_consensus.cc:729] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a14412800a764224b19e7142ef0de183, State: Initialized, Role: FOLLOWER
16:15:36.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.857282  4717 consensus_queue.cc:260] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } }
16:15:36.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.880476  4674 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a14412800a764224b19e7142ef0de183"
16:15:36.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.881318  4674 raft_consensus.cc:3037] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.883769  4675 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a14412800a764224b19e7142ef0de183" is_pre_election: true
16:15:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.907101  4674 raft_consensus.cc:2454] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bd5ab6e1c1d0479dbe78378bbf21b740 in term 1.
16:15:36.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.908937  4673 raft_consensus.cc:1261] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [term 1 FOLLOWER]: Refusing update from remote peer bd5ab6e1c1d0479dbe78378bbf21b740: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:36.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.916244  4900 consensus_queue.cc:1035] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [LEADER]: Connected to new peer: Peer: permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:15:36.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.925262  4917 sys_catalog.cc:455] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [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: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:36.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.926563  4717 sys_catalog.cc:564] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.927968  4917 sys_catalog.cc:458] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.988940  4647 tablet.cc:2369] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:37.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.033129  4919 sys_catalog.cc:455] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:37.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.033969  4919 sys_catalog.cc:458] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: This master's current role is: FOLLOWER
16:15:37.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.035369  4917 sys_catalog.cc:455] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd5ab6e1c1d0479dbe78378bbf21b740. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:37.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.036064  4917 sys_catalog.cc:458] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183 [sys.catalog]: This master's current role is: FOLLOWER
16:15:37.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.042950  4911 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:37.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.044183  4911 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:37.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.045230  4911 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:37.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.045876  4953 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
16:15:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.100811  4911 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:37.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.102630  4911 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.96.193
16:15:37.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.164237  4911 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.193:0
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data/info.pb
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.193
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.193
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/logs
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.166052  4911 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:15:37.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.167354  4593 debug-util.cc:398] Leaking SignalData structure 0x7b08000723c0 after lost signal to thread 4502
16:15:37.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.168067  4593 debug-util.cc:398] Leaking SignalData structure 0x7b08000815c0 after lost signal to thread 4598
16:15:37.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.173714  4871 catalog_manager.cc:1259] Loaded cluster ID: 7e44a55228284cc8ae94cd214d1fad72
16:15:37.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.173965  4871 catalog_manager.cc:1552] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: loading cluster ID for follower catalog manager: success
16:15:37.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.179714  4911 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:37.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.189163  4871 catalog_manager.cc:1574] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: acquiring CA information for follower catalog manager: success
16:15:37.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.195240  4871 catalog_manager.cc:1602] T 00000000000000000000000000000000 P dc4c3c6f714643f1811d70c2dfa4fc73: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:15:37.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.246181  4955 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:15:37.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.416539  4963 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "bd5ab6e1c1d0479dbe78378bbf21b740" member_type: VOTER last_known_addr { host: "127.4.96.254" port: 35939 } } peers { permanent_uuid: "a14412800a764224b19e7142ef0de183" member_type: VOTER last_known_addr { host: "127.4.96.253" port: 44651 } } peers { permanent_uuid: "dc4c3c6f714643f1811d70c2dfa4fc73" member_type: VOTER last_known_addr { host: "127.4.96.252" port: 37247 } } }
16:15:37.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.420871  4963 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd5ab6e1c1d0479dbe78378bbf21b740 [sys.catalog]: This master's current role is: LEADER
16:15:38.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:38.076284  4953 catalog_manager.cc:1259] Loaded cluster ID: 7e44a55228284cc8ae94cd214d1fad72
16:15:38.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:38.076565  4953 catalog_manager.cc:1552] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: loading cluster ID for follower catalog manager: success
16:15:38.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:38.100760  4953 catalog_manager.cc:1574] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: acquiring CA information for follower catalog manager: success
16:15:38.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:38.107043  4953 catalog_manager.cc:1602] T 00000000000000000000000000000000 P a14412800a764224b19e7142ef0de183: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:15:39.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.250092  4956 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:15:39.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.253628  4958 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:15:39.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.251184  4911 server_base.cc:1034] running on GCE node
16:15:39.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.059998  4911 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:39.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.067701  4911 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.075785  4911 hybrid_clock.cc:648] HybridClock initialized: now 1786464939075677 us; error 76 us; skew 500 ppm
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.076964  4911 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:39.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.098098  4911 webserver.cc:460] Webserver started at http://127.4.96.193:37599/ using document root <none> and password file <none>
16:15:39.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.099737  4911 fs_manager.cc:359] Metadata directory not provided
16:15:39.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.100265  4911 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:39.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.100996  4911 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:39.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.118396  4911 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data/instance:
16:15:39.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc"
16:15:39.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-jpj1"
16:15:39.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.120359  4911 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal/instance:
16:15:39.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc"
16:15:39.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-jpj1"
16:15:39.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.143796  4911 fs_manager.cc:691] Time spent creating directory manager: real 0.022s	user 0.008s	sys 0.000s
16:15:39.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.168591  4974 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:39.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.173846  4911 fs_manager.cc:725] Time spent opening block manager: real 0.025s	user 0.004s	sys 0.004s
16:15:39.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.174321  4911 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal
16:15:39.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc"
16:15:39.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-jpj1"
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.174801  4911 fs_report.cc:383] FS layout report
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data/data
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:39.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:39.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:39.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:39.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:39.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:39.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:39.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.323004  4911 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:39.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.326241  4911 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:15:39.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.326845  4911 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:39.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.351818  4911 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.360792  4911 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.361097  4911 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:15:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.361400  4911 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.361605  4911 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:39.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.898502  4911 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.193:38753
16:15:39.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.898648  5155 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.193:38753 every 8 connection(s)
16:15:39.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.902261  4911 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/data/info.pb
16:15:39.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.909118  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 4911
16:15:39.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.909584  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-0/wal/instance
16:15:39.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.921021  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/logs
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data/info.pb
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:39.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.194:0
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.194
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.194
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:39.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:39.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.971339  5157 heartbeater.cc:347] Connected to a master server at 127.4.96.253:44651
16:15:39.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.971812  5157 heartbeater.cc:464] Registering TS with master...
16:15:39.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.973052  5157 heartbeater.cc:511] Master 127.4.96.253:44651 requested a full tablet report, sending...
16:15:39.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.977023  4664 ts_manager.cc:194] Registered new tserver with Master: b89cd9b852394ad6a9eb87dbd81f5bfc (127.4.96.193:38753)
16:15:39.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.982118  5156 heartbeater.cc:347] Connected to a master server at 127.4.96.252:37247
16:15:39.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.982463  5156 heartbeater.cc:464] Registering TS with master...
16:15:39.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.983348  5156 heartbeater.cc:511] Master 127.4.96.252:37247 requested a full tablet report, sending...
16:15:39.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.984609  5160 heartbeater.cc:347] Connected to a master server at 127.4.96.254:35939
16:15:39.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.984932  5160 heartbeater.cc:464] Registering TS with master...
16:15:39.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.985674  5160 heartbeater.cc:511] Master 127.4.96.254:35939 requested a full tablet report, sending...
16:15:39.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.988788  4788 ts_manager.cc:194] Registered new tserver with Master: b89cd9b852394ad6a9eb87dbd81f5bfc (127.4.96.193:38753)
16:15:39.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.988790  4551 ts_manager.cc:194] Registered new tserver with Master: b89cd9b852394ad6a9eb87dbd81f5bfc (127.4.96.193:38753)
16:15:39.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.991266  4551 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.96.193:49083
16:15:40.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.351696  5167 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:40.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.352260  5167 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:40.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.352864  5167 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:40.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.385214  5167 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:40.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.386230  5167 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.96.194
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:40.422734  5167 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.194:0
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:40.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data/info.pb
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.194
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.194
16:15:40.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/logs
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:40.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:40.424326  5167 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:15:40.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:40.426537  5167 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:40.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.450886  5173 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:15:40.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:40.996634  5160 heartbeater.cc:503] Master 127.4.96.254:35939 was elected leader, sending a full tablet report...
16:15:41.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.454484  5184 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:15:41.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:40.450915  5175 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:15:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.637677  5176 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1184 milliseconds
16:15:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.637815  5167 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:15:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.638984  5167 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:41.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.642140  5167 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:41.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.643604  5167 hybrid_clock.cc:648] HybridClock initialized: now 1786464941643543 us; error 66 us; skew 500 ppm
16:15:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.644647  5167 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.652324  5167 webserver.cc:460] Webserver started at http://127.4.96.194:35313/ using document root <none> and password file <none>
16:15:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.653546  5167 fs_manager.cc:359] Metadata directory not provided
16:15:41.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.653824  5167 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:41.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.654387  5167 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:41.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.661353  5167 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data/instance:
16:15:41.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2bf53cd8d3734e06b820748419ccf397"
16:15:41.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-jpj1"
16:15:41.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.662850  5167 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal/instance:
16:15:41.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2bf53cd8d3734e06b820748419ccf397"
16:15:41.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-jpj1"
16:15:41.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.672237  5167 fs_manager.cc:691] Time spent creating directory manager: real 0.009s	user 0.006s	sys 0.001s
16:15:41.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.679489  5202 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:41.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.680656  5167 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.001s
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.680969  5167 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2bf53cd8d3734e06b820748419ccf397"
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-jpj1"
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.681288  5167 fs_report.cc:383] FS layout report
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data/data
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:41.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:41.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:41.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.714389  5167 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:41.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.715849  5167 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:15:41.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.716280  5167 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:41.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.718770  5167 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:41.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.723407  5167 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:41.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.723620  5167 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.001s	sys 0.000s
16:15:41.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.723832  5167 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:41.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.723959  5167 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:41.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.861358  5167 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.194:36981
16:15:41.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.861483  5384 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.194:36981 every 8 connection(s)
16:15:41.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.863978  5167 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/data/info.pb
16:15:41.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.868580  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 5167
16:15:41.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.869264  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-1/wal/instance
16:15:41.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.884227  4483 external_mini_cluster.cc:1326] Running /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:41.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu
16:15:41.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal
16:15:41.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/logs
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data/info.pb
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.195:0
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.195
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.195
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:41.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:41.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.921591  5385 heartbeater.cc:347] Connected to a master server at 127.4.96.252:37247
16:15:41.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.922169  5385 heartbeater.cc:464] Registering TS with master...
16:15:41.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.922647  5390 heartbeater.cc:347] Connected to a master server at 127.4.96.254:35939
16:15:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.923018  5390 heartbeater.cc:464] Registering TS with master...
16:15:41.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.923584  5385 heartbeater.cc:511] Master 127.4.96.252:37247 requested a full tablet report, sending...
16:15:41.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.924021  5390 heartbeater.cc:511] Master 127.4.96.254:35939 requested a full tablet report, sending...
16:15:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.926529  4551 ts_manager.cc:194] Registered new tserver with Master: 2bf53cd8d3734e06b820748419ccf397 (127.4.96.194:36981)
16:15:41.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.927103  4788 ts_manager.cc:194] Registered new tserver with Master: 2bf53cd8d3734e06b820748419ccf397 (127.4.96.194:36981)
16:15:41.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.928768  4551 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.96.194:56479
16:15:41.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.934978  5387 heartbeater.cc:347] Connected to a master server at 127.4.96.253:44651
16:15:41.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.935315  5387 heartbeater.cc:464] Registering TS with master...
16:15:41.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.936002  5387 heartbeater.cc:511] Master 127.4.96.253:44651 requested a full tablet report, sending...
16:15:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.938141  4664 ts_manager.cc:194] Registered new tserver with Master: 2bf53cd8d3734e06b820748419ccf397 (127.4.96.194:36981)
16:15:42.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.223999  5398 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:42.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.224555  5398 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:42.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.225152  5398 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:42.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.257241  5398 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:42.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.258220  5398 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.96.195
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.293704  5398 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.96.212:46489
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.96.195:0
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:42.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data/info.pb
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.96.195
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.96.254:35939,127.4.96.253:44651,127.4.96.252:37247
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.96.195
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/logs
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:42.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.295270  5398 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:15:42.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.296927  5398 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:42.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.319690  5419 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:15:42.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.933327  5390 heartbeater.cc:503] Master 127.4.96.254:35939 was elected leader, sending a full tablet report...
16:15:43.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.320367  5411 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:15:43.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:42.320855  5409 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:15:43.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.322664  5398 server_base.cc:1034] running on GCE node
16:15:43.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.435079  5398 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:43.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.437803  5398 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:43.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.439241  5398 hybrid_clock.cc:648] HybridClock initialized: now 1786464943439202 us; error 53 us; skew 500 ppm
16:15:43.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.440063  5398 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:43.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.446959  5398 webserver.cc:460] Webserver started at http://127.4.96.195:38151/ using document root <none> and password file <none>
16:15:43.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.447907  5398 fs_manager.cc:359] Metadata directory not provided
16:15:43.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.448096  5398 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:43.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.448488  5398 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:43.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.453390  5398 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data/instance:
16:15:43.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "009fe80a8fdd4c718cb34729420fa0c8"
16:15:43.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:43 on dist-test-slave-jpj1"
16:15:43.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.454538  5398 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal/instance:
16:15:43.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "009fe80a8fdd4c718cb34729420fa0c8"
16:15:43.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:43 on dist-test-slave-jpj1"
16:15:43.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.461594  5398 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.009s	sys 0.000s
16:15:43.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.467514  5435 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:43.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.468533  5398 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.002s
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.468870  5398 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data,/tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "009fe80a8fdd4c718cb34729420fa0c8"
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:43 on dist-test-slave-jpj1"
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.469197  5398 fs_report.cc:383] FS layout report
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data/data
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:43.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:43.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:43.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.520328  5398 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:43.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.521993  5398 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:15:43.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.522539  5398 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:43.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.525233  5398 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:43.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.529500  5398 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:43.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.529839  5398 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:15:43.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.530184  5398 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:43.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.530390  5398 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:43.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.673456  5398 rpc_server.cc:307] RPC server started. Bound to: 127.4.96.195:35169
16:15:43.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.673580  5610 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.96.195:35169 every 8 connection(s)
16:15:43.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.676100  5398 server_base.cc:1166] Dumped server information to /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/data/info.pb
16:15:43.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.681883  4483 external_mini_cluster.cc:1388] Started /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu as pid 5398
16:15:43.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.682391  4483 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task0MXRtd/test-tmp/mini-kudu-cluster6051011074586241493/ts-2/wal/instance
16:15:43.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.714988  5611 heartbeater.cc:347] Connected to a master server at 127.4.96.252:37247
16:15:43.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.715444  5611 heartbeater.cc:464] Registering TS with master...
16:15:43.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.716447  5616 heartbeater.cc:347] Connected to a master server at 127.4.96.254:35939
16:15:43.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.716789  5611 heartbeater.cc:511] Master 127.4.96.252:37247 requested a full tablet report, sending...
16:15:43.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.717152  5616 heartbeater.cc:464] Registering TS with master...
16:15:43.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.717919  5615 heartbeater.cc:347] Connected to a master server at 127.4.96.253:44651
16:15:43.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.718079  5616 heartbeater.cc:511] Master 127.4.96.254:35939 requested a full tablet report, sending...
16:15:43.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.718281  5615 heartbeater.cc:464] Registering TS with master...
16:15:43.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.719120  5615 heartbeater.cc:511] Master 127.4.96.253:44651 requested a full tablet report, sending...
16:15:43.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.720171  4788 ts_manager.cc:194] Registered new tserver with Master: 009fe80a8fdd4c718cb34729420fa0c8 (127.4.96.195:35169)
16:15:43.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.720484  4551 ts_manager.cc:194] Registered new tserver with Master: 009fe80a8fdd4c718cb34729420fa0c8 (127.4.96.195:35169)
16:15:43.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.722467  4551 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.96.195:39159
16:15:43.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.723318  4664 ts_manager.cc:194] Registered new tserver with Master: 009fe80a8fdd4c718cb34729420fa0c8 (127.4.96.195:35169)
16:15:43.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.729522  4483 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
16:15:43.740 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:15:43.741 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

16:15:43.754 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.96.254"
      port: 35939
    }
    bound_http_address {
      host: "127.4.96.254"
      port: 44047
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.96.253"
      port: 44651
    }
    bound_http_address {
      host: "127.4.96.253"
      port: 41365
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.96.252"
      port: 37247
    }
    bound_http_address {
      host: "127.4.96.252"
      port: 39849
    }
  }
}

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

16:15:43.763 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.96.193"
      port: 38753
    }
    bound_http_address {
      host: "127.4.96.193"
      port: 37599
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.96.194"
      port: 36981
    }
    bound_http_address {
      host: "127.4.96.194"
      port: 35313
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.96.195"
      port: 35169
    }
    bound_http_address {
      host: "127.4.96.195"
      port: 38151
    }
  }
}

16:15:43.763 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
16:15:43.950 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
16:15:44.120 [DEBUG - main] (Connection.java:748) [peer master-127.4.96.252:37247(127.4.96.252:37247)] connecting to peer
16:15:44.174 [DEBUG - main] (Connection.java:748) [peer master-127.4.96.253:44651(127.4.96.253:44651)] connecting to peer
16:15:44.180 [DEBUG - main] (Connection.java:748) [peer master-127.4.96.254:35939(127.4.96.254:35939)] connecting to peer
16:15:44.213 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.4.96.253:44651(127.4.96.253:44651)] Successfully connected to peer
16:15:44.213 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.4.96.252:37247(127.4.96.252:37247)] Successfully connected to peer
16:15:44.287 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.4.96.254:35939(127.4.96.254:35939)] Successfully connected to peer
16:15:44.312 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.96.253
16:15:44.312 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.96.252
16:15:44.513 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.96.254
16:15:44.546 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x433efd4f, L:/127.0.0.1:51754 - R:/127.4.96.253:44651] using SASL/PLAIN
16:15:44.546 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x6b8ee912, L:/127.0.0.1:38288 - R:/127.4.96.252:37247] using SASL/PLAIN
16:15:44.563 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xf998d1d2, L:/127.0.0.1:36832 - R:/127.4.96.254:35939] using SASL/PLAIN
16:15:44.597 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
16:15:44.598 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=518), Traces: [0ms] refreshing cache from master, [27ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.96.252:37247, [89ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.96.253:44651, [90ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.96.254:35939, [475ms] Sub RPC ConnectToMaster: received response from server master-127.4.96.253:44651: OK, [475ms] Sub RPC ConnectToMaster: received response from server master-127.4.96.252:37247: OK, [485ms] Sub RPC ConnectToMaster: received response from server master-127.4.96.254:35939: OK, deferred=null) after lookup
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.662144  4551 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:36832:
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786464930296"
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
16:15:44.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
16:15:44.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:44.666162  4551 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-1786464930296 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
16:15:44.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.726792  5616 heartbeater.cc:503] Master 127.4.96.254:35939 was elected leader, sending a full tablet report...
16:15:44.746 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 57efbe26baee48298e24f8a712d41df1
16:15:44.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.777743  5052 tablet_service.cc:1467] Processing CreateTablet for tablet b6c3facc8b9a4599aa8a20da609ee2ec (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464930296 [id=57efbe26baee48298e24f8a712d41df1]), partition=RANGE (key) PARTITION UNBOUNDED
16:15:44.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.780002  5052 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet b6c3facc8b9a4599aa8a20da609ee2ec. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:44.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.783514  5509 tablet_service.cc:1467] Processing CreateTablet for tablet b6c3facc8b9a4599aa8a20da609ee2ec (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464930296 [id=57efbe26baee48298e24f8a712d41df1]), partition=RANGE (key) PARTITION UNBOUNDED
16:15:44.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.784494  5279 tablet_service.cc:1467] Processing CreateTablet for tablet b6c3facc8b9a4599aa8a20da609ee2ec (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786464930296 [id=57efbe26baee48298e24f8a712d41df1]), partition=RANGE (key) PARTITION UNBOUNDED
16:15:44.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.786284  5509 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet b6c3facc8b9a4599aa8a20da609ee2ec. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:44.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.786842  5279 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet b6c3facc8b9a4599aa8a20da609ee2ec. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:44.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.809841  5660 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Bootstrap starting.
16:15:44.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.811391  5661 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Bootstrap starting.
16:15:44.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.814352  5662 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Bootstrap starting.
16:15:44.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.816921  5660 tablet_bootstrap.cc:654] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Neither blocks nor log segments found. Creating new log.
16:15:44.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.818353  5661 tablet_bootstrap.cc:654] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Neither blocks nor log segments found. Creating new log.
16:15:44.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.819197  5660 log.cc:824] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Log is configured to *not* fsync() on all Append() calls
16:15:44.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.819589  5662 tablet_bootstrap.cc:654] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Neither blocks nor log segments found. Creating new log.
16:15:44.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.821719  5662 log.cc:824] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Log is configured to *not* fsync() on all Append() calls
16:15:44.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.822275  5661 log.cc:824] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Log is configured to *not* fsync() on all Append() calls
16:15:44.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.825939  5660 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: No bootstrap required, opened a new log
16:15:44.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.826465  5660 ts_tablet_manager.cc:1397] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Time spent bootstrapping tablet: real 0.017s	user 0.013s	sys 0.000s
16:15:44.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.827184  5662 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: No bootstrap required, opened a new log
16:15:44.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.827819  5662 ts_tablet_manager.cc:1397] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Time spent bootstrapping tablet: real 0.014s	user 0.009s	sys 0.003s
16:15:44.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.833216  5661 tablet_bootstrap.cc:492] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: No bootstrap required, opened a new log
16:15:44.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.833663  5661 ts_tablet_manager.cc:1397] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Time spent bootstrapping tablet: real 0.023s	user 0.014s	sys 0.004s
16:15:44.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.855247  5661 raft_consensus.cc:348] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.856142  5661 raft_consensus.cc:374] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:44.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.856442  5661 raft_consensus.cc:729] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b89cd9b852394ad6a9eb87dbd81f5bfc, State: Initialized, Role: FOLLOWER
16:15:44.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.856309  5660 raft_consensus.cc:348] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.857383  5660 raft_consensus.cc:374] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:44.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.857672  5660 raft_consensus.cc:729] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 009fe80a8fdd4c718cb34729420fa0c8, State: Initialized, Role: FOLLOWER
16:15:44.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.857326  5661 consensus_queue.cc:260] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [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: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.857992  5662 raft_consensus.cc:348] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.858851  5662 raft_consensus.cc:374] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:44.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.858508  5660 consensus_queue.cc:260] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [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: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.859125  5662 raft_consensus.cc:729] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2bf53cd8d3734e06b820748419ccf397, State: Initialized, Role: FOLLOWER
16:15:44.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.860037  5662 consensus_queue.cc:260] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [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: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:44.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.870044  5660 ts_tablet_manager.cc:1428] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Time spent starting tablet: real 0.043s	user 0.032s	sys 0.012s
16:15:44.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.885208  5662 ts_tablet_manager.cc:1428] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Time spent starting tablet: real 0.057s	user 0.029s	sys 0.015s
16:15:44.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:44.888032  5393 tablet.cc:2369] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:44.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.895104  5661 ts_tablet_manager.cc:1428] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Time spent starting tablet: real 0.061s	user 0.028s	sys 0.021s
16:15:44.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:44.941991  5617 tablet.cc:2369] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:44.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:44.957813  5162 tablet.cc:2369] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:45.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.023444  5669 raft_consensus.cc:482] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:15:45.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.024109  5669 raft_consensus.cc:504] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:45.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.026718  5669 leader_election.cc:288] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers b89cd9b852394ad6a9eb87dbd81f5bfc (127.4.96.193:38753), 2bf53cd8d3734e06b820748419ccf397 (127.4.96.194:36981)
16:15:45.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.046278  5312 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "b6c3facc8b9a4599aa8a20da609ee2ec" candidate_uuid: "009fe80a8fdd4c718cb34729420fa0c8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2bf53cd8d3734e06b820748419ccf397" is_pre_election: true
16:15:45.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.046267  5085 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "b6c3facc8b9a4599aa8a20da609ee2ec" candidate_uuid: "009fe80a8fdd4c718cb34729420fa0c8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" is_pre_election: true
16:15:45.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.047252  5085 raft_consensus.cc:2454] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 009fe80a8fdd4c718cb34729420fa0c8 in term 0.
16:15:45.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.047252  5312 raft_consensus.cc:2454] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 009fe80a8fdd4c718cb34729420fa0c8 in term 0.
16:15:45.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.048768  5436 leader_election.cc:302] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [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: 009fe80a8fdd4c718cb34729420fa0c8, b89cd9b852394ad6a9eb87dbd81f5bfc; no voters: 
16:15:45.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.049543  5669 raft_consensus.cc:2781] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:15:45.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.049876  5669 raft_consensus.cc:482] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:15:45.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.050101  5669 raft_consensus.cc:3037] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 0 FOLLOWER]: Advancing to term 1
16:15:45.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.054675  5669 raft_consensus.cc:504] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:45.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.056084  5669 leader_election.cc:288] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [CANDIDATE]: Term 1 election: Requested vote from peers b89cd9b852394ad6a9eb87dbd81f5bfc (127.4.96.193:38753), 2bf53cd8d3734e06b820748419ccf397 (127.4.96.194:36981)
16:15:45.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.057119  5085 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "b6c3facc8b9a4599aa8a20da609ee2ec" candidate_uuid: "009fe80a8fdd4c718cb34729420fa0c8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc"
16:15:45.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.057188  5312 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "b6c3facc8b9a4599aa8a20da609ee2ec" candidate_uuid: "009fe80a8fdd4c718cb34729420fa0c8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2bf53cd8d3734e06b820748419ccf397"
16:15:45.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.057582  5085 raft_consensus.cc:3037] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 0 FOLLOWER]: Advancing to term 1
16:15:45.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.057736  5312 raft_consensus.cc:3037] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 0 FOLLOWER]: Advancing to term 1
16:15:45.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.061993  5085 raft_consensus.cc:2454] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 009fe80a8fdd4c718cb34729420fa0c8 in term 1.
16:15:45.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.062084  5312 raft_consensus.cc:2454] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 009fe80a8fdd4c718cb34729420fa0c8 in term 1.
16:15:45.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.062956  5436 leader_election.cc:302] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [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: 009fe80a8fdd4c718cb34729420fa0c8, b89cd9b852394ad6a9eb87dbd81f5bfc; no voters: 
16:15:45.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.063673  5669 raft_consensus.cc:2781] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 1 FOLLOWER]: Leader election won for term 1
16:15:45.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.065392  5669 raft_consensus.cc:686] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [term 1 LEADER]: Becoming Leader. State: Replica: 009fe80a8fdd4c718cb34729420fa0c8, State: Running, Role: LEADER
16:15:45.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.066242  5669 consensus_queue.cc:237] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [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: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } }
16:15:45.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.079259  4552 catalog_manager.cc:5495] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 reported cstate change: term changed from 0 to 1, leader changed from <none> to 009fe80a8fdd4c718cb34729420fa0c8 (127.4.96.195). New cstate: current_term: 1 leader_uuid: "009fe80a8fdd4c718cb34729420fa0c8" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "009fe80a8fdd4c718cb34729420fa0c8" member_type: VOTER last_known_addr { host: "127.4.96.195" port: 35169 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 } health_report { overall_health: UNKNOWN } } }
16:15:45.467 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet b6c3facc8b9a4599aa8a20da609ee2ec for table 'org.apache.kudu.client.TestHybridTime-1786464930296' with partition [<start>, <end>)
16:15:45.475 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=b6c3facc8b9a4599aa8a20da609ee2ec@[009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)[L],2bf53cd8d3734e06b820748419ccf397(127.4.96.194:36981),b89cd9b852394ad6a9eb87dbd81f5bfc(127.4.96.193:38753)]}]
16:15:45.477 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=22), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.4.96.254:35939, [11ms] Sub RPC GetTableLocations: received response from server master-127.4.96.254:35939: OK, deferred=null) after lookup
16:15:45.488 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)] connecting to peer
16:15:45.490 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)] Successfully connected to peer
16:15:45.552 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x072d6324, L:/127.0.0.1:37178 - R:/127.4.96.195:35169] using TOKEN/null
16:15:45.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.565725  5312 raft_consensus.cc:1261] T b6c3facc8b9a4599aa8a20da609ee2ec P 2bf53cd8d3734e06b820748419ccf397 [term 1 FOLLOWER]: Refusing update from remote peer 009fe80a8fdd4c718cb34729420fa0c8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:45.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.566258  5085 raft_consensus.cc:1261] T b6c3facc8b9a4599aa8a20da609ee2ec P b89cd9b852394ad6a9eb87dbd81f5bfc [term 1 FOLLOWER]: Refusing update from remote peer 009fe80a8fdd4c718cb34729420fa0c8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:45.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.567495  5675 consensus_queue.cc:1035] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "2bf53cd8d3734e06b820748419ccf397" member_type: VOTER last_known_addr { host: "127.4.96.194" port: 36981 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:15:45.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.568267  5669 consensus_queue.cc:1035] T b6c3facc8b9a4599aa8a20da609ee2ec P 009fe80a8fdd4c718cb34729420fa0c8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "b89cd9b852394ad6a9eb87dbd81f5bfc" member_type: VOTER last_known_addr { host: "127.4.96.193" port: 38753 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:15:45.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.591094  5687 mvcc.cc:205] Tried to move back new op lower bound from 7317360417022156800 to 7317360414999347200. Current Snapshot: MvccSnapshot[applied={T|T < 7317360417022156800}]
16:15:45.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.591046  5682 mvcc.cc:205] Tried to move back new op lower bound from 7317360417022156800 to 7317360414999347200. Current Snapshot: MvccSnapshot[applied={T|T < 7317360417022156800}]
16:15:45.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.648918  5691 mvcc.cc:205] Tried to move back new op lower bound from 7317360417022156800 to 7317360414999347200. Current Snapshot: MvccSnapshot[applied={T|T < 7317360417022156800}]
16:15:45.666 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.702 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.723 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.727 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1291516911(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:15:45.748 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.749 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@964076156(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:15:45.765 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.766 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@2011623719(state=PENDING, result=null, callback=<none>, errback=<none>)}
16:15:45.782 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
16:15:45.834 [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-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.848 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317360437502156801) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.859 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317360437502156805) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.870 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317360437502156811) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.879 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317360437502156816) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.891 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317360437502156821) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.908 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317360437502156825) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.921 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317360437502156826) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786464930296, tablet=b6c3facc8b9a4599aa8a20da609ee2ec, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
16:15:45.928 [DEBUG - main] (Connection.java:575) [peer 009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)] disconnecting while in state READY
16:15:45.930 [DEBUG - main] (Connection.java:575) [peer master-127.4.96.254:35939(127.4.96.254:35939)] disconnecting while in state READY
16:15:45.931 [DEBUG - main] (Connection.java:575) [peer master-127.4.96.253:44651(127.4.96.253:44651)] disconnecting while in state READY
16:15:45.931 [DEBUG - main] (Connection.java:575) [peer master-127.4.96.252:37247(127.4.96.252:37247)] disconnecting while in state READY
16:15:45.939 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.4.96.254:35939(127.4.96.254:35939)] handling channelInactive
16:15:45.940 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.4.96.254:35939(127.4.96.254:35939)] cleaning up while in state READY due to: connection closed
16:15:45.941 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.4.96.252:37247(127.4.96.252:37247)] handling channelInactive
16:15:45.941 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.4.96.252:37247(127.4.96.252:37247)] cleaning up while in state READY due to: connection closed
16:15:45.942 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:15:45.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.949777  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 4911
16:15:45.968 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)] handling channelInactive
16:15:45.969 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 009fe80a8fdd4c718cb34729420fa0c8(127.4.96.195:35169)] cleaning up while in state READY due to: connection closed
16:15:45.969 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.4.96.253:44651(127.4.96.253:44651)] handling channelInactive
16:15:45.969 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.4.96.253:44651(127.4.96.253:44651)] cleaning up while in state READY due to: connection closed
16:15:46.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:46.000190  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 5167
16:15:46.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:46.043239  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 5398
16:15:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:46.087183  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 4497
16:15:46.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:46.125106  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 4605
16:15:46.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:46.158197  4483 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task0MXRtd/build/tsan/bin/kudu with pid 4720
16:15:47.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:47Z chronyd exiting

Time: 18.184

OK (1 test)

