JUnit version 4.13.2
.05:22:33.354 [INFO - main] (RandomUtils.java:49) Using random seed: 1783488153349
05:22:33.372 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
05:22:33.430 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
05:22:33.439 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskjRUvUo/test-tmp
05:22:33.441 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
05:22:33.445 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskjRUvUo/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
05:22:33.661 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

05:22:33.838 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
05:22:33.840 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

05:22:33.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:33.844250  7812 mini_oidc.cc:152] Starting JWKS server
05:22:33.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:33.848759  7812 webserver.cc:460] Webserver started at http://127.0.0.1:37899/ using document root <none> and password file <none>
05:22:33.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:33.849351  7812 mini_oidc.cc:189] Starting OIDC Discovery server
05:22:33.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:33.852020  7812 webserver.cc:460] Webserver started at http://127.0.0.1:33351/ using document root <none> and password file <none>
05:22:33.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T05:22:33Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
05:22:33.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T05:22:33Z Disabled control of system clock
05:22:33.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:33.904398  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:33.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/logs
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data/info.pb
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:33.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:33.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.62:37979
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.62
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:33.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:33.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:33.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json with env {}
05:22:34.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.210665  7824 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:34.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.211455  7824 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:34.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.212240  7824 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:34.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.245556  7824 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
05:22:34.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.245846  7824 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:34.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.246042  7824 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
05:22:34.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.246219  7824 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
05:22:34.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.246470  7824 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
05:22:34.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.246681  7824 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:37899/jwks.json
05:22:34.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:34.283667  7824 master_runner.cc:386] Master server non-default flags:
05:22:34.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:34.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:34.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:34.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:34.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data
05:22:34.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.62:37979
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data/info.pb
05:22:34.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.62
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/logs
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
05:22:34.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:34.284987  7824 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:34.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:34.286950  7824 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:34.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.307013  7833 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
05:22:35.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.307117  7831 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
05:22:35.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:34.307554  7830 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
05:22:35.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:34.308197  7824 server_base.cc:1034] running on GCE node
05:22:35.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.505234  7824 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:35.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.508153  7824 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:35.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.509503  7824 hybrid_clock.cc:648] HybridClock initialized: now 1783488155509467 us; error 53 us; skew 500 ppm
05:22:35.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.510349  7824 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:35.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.522104  7824 webserver.cc:460] Webserver started at http://127.7.161.62:39883/ using document root <none> and password file <none>
05:22:35.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.523092  7824 fs_manager.cc:359] Metadata directory not provided
05:22:35.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.523285  7824 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:35.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.523676  7824 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:35.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.528726  7824 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data/instance:
05:22:35.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff983c58368d4af494c163c20941ab46"
05:22:35.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:35 on dist-test-slave-gttl"
05:22:35.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.530025  7824 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal/instance:
05:22:35.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff983c58368d4af494c163c20941ab46"
05:22:35.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:35 on dist-test-slave-gttl"
05:22:35.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.537444  7824 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.001s
05:22:35.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.543668  7840 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:35.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.544938  7824 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.006s	sys 0.000s
05:22:35.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.545305  7824 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal
05:22:35.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff983c58368d4af494c163c20941ab46"
05:22:35.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:35 on dist-test-slave-gttl"
05:22:35.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.545684  7824 fs_report.cc:383] FS layout report
05:22:35.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data/data
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:35.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:35.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:35.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.587643  7824 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:35.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.589231  7824 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
05:22:35.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.589643  7824 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:35.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.660830  7824 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.62:37979
05:22:35.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.660902  7891 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.62:37979 every 8 connection(s)
05:22:35.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.663436  7824 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/data/info.pb
05:22:35.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.668601  7892 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:35.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.670595  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 7824
05:22:35.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.671119  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-0/wal/instance
05:22:35.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.676445  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/logs
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data/info.pb
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:35.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.61:34521
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.61
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:35.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:35.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json with env {}
05:22:35.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.683667  7892 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } has no permanent_uuid. Determining permanent_uuid...
05:22:35.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.717712  7892 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } has no permanent_uuid. Determining permanent_uuid...
05:22:35.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:35.720155  7842 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:35.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:35.724466  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:35.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.773944  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 1
05:22:35.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:35.778203  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:35.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.846604  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 2
05:22:35.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:35.850792  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:35.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:35.942227  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 3
05:22:35.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:35.946724  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:36.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.010108  7894 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:36.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.010848  7894 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:36.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.011526  7894 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:36.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.042727  7894 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
05:22:36.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.043125  7894 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:36.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.043452  7894 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
05:22:36.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.043874  7894 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
05:22:36.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.044209  7894 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
05:22:36.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.044467  7894 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:37899/jwks.json
05:22:36.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.080370  7894 master_runner.cc:386] Master server non-default flags:
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:36.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.61:34521
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data/info.pb
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.61
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:36.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/logs
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:36.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
05:22:36.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:36.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:36.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:36.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:36.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:36.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:36.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.082005  7894 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:36.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.084316  7894 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:36.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.090132  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 4
05:22:36.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.094980  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:36.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.104947  7904 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
05:22:36.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.394522  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 5
05:22:36.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.400079  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:36.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:36.947512  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 6
05:22:36.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.955166  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.61:34521: Network error: Client connection negotiation failed: client connection to 127.7.161.61:34521: connect: Connection refused (error 111)
05:22:37.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.105675  7903 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
05:22:37.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:36.105336  7906 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
05:22:37.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.343393  7905 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
05:22:37.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.343681  7894 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
05:22:37.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.349215  7894 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:37.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.351981  7894 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:37.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.353408  7894 hybrid_clock.cc:648] HybridClock initialized: now 1783488157353373 us; error 44 us; skew 500 ppm
05:22:37.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.354472  7894 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:37.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.361263  7894 webserver.cc:460] Webserver started at http://127.7.161.61:39033/ using document root <none> and password file <none>
05:22:37.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.362442  7894 fs_manager.cc:359] Metadata directory not provided
05:22:37.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.362699  7894 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:37.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.363351  7894 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:37.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.368878  7894 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data/instance:
05:22:37.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0ada1b2bd07439785f266ed6373d4bb"
05:22:37.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:37 on dist-test-slave-gttl"
05:22:37.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.370440  7894 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal/instance:
05:22:37.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0ada1b2bd07439785f266ed6373d4bb"
05:22:37.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:37 on dist-test-slave-gttl"
05:22:37.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.380275  7894 fs_manager.cc:691] Time spent creating directory manager: real 0.009s	user 0.010s	sys 0.000s
05:22:37.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.386185  7915 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:37.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.387373  7894 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
05:22:37.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.387851  7894 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal
05:22:37.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e0ada1b2bd07439785f266ed6373d4bb"
05:22:37.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:37 on dist-test-slave-gttl"
05:22:37.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.388342  7894 fs_report.cc:383] FS layout report
05:22:37.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:37.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data/data
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:37.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.426321  7894 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:37.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.428036  7894 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
05:22:37.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.428615  7894 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:37.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.505445  7894 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.61:34521
05:22:37.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.505561  7966 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.61:34521 every 8 connection(s)
05:22:37.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.508380  7894 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/data/info.pb
05:22:37.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.515184  7967 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:37.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.517096  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 7894
05:22:37.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.517551  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-1/wal/instance
05:22:37.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.519538  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/logs
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data/info.pb
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:37.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.60:40177
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.60
05:22:37.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:37.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json with env {}
05:22:37.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.528317  7967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } has no permanent_uuid. Determining permanent_uuid...
05:22:37.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.568351  7967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } has no permanent_uuid. Determining permanent_uuid...
05:22:37.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.585547  7967 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } has no permanent_uuid. Determining permanent_uuid...
05:22:37.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.587679  7919 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:37.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.591825  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:37.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.641417  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 1
05:22:37.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.646222  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:37.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.714607  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 2
05:22:37.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.718562  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:37.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.810007  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 3
05:22:37.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.814508  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:37.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.848914  7969 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:37.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.849514  7969 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:37.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.849975  7969 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:37.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.881327  7969 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
05:22:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.881809  7969 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.882145  7969 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
05:22:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.882531  7969 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
05:22:37.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.882899  7969 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
05:22:37.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.883172  7969 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:37899/jwks.json
05:22:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.923069  7969 master_runner.cc:386] Master server non-default flags:
05:22:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.60:40177
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
05:22:37.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37899/jwks.json
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data/info.pb
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.60
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/logs
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:37.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:37.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.924736  7969 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:37.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.927158  7969 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:37.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.946909  7979 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
05:22:37.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.957960  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 4
05:22:37.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.961926  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.015849  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } attempt: 7
05:22:38.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.035200  7892 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } has no permanent_uuid. Determining permanent_uuid...
05:22:38.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.041554  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.100009  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 1
05:22:38.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.104511  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.185963  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 2
05:22:38.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.191435  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.261439  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 5
05:22:38.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.266788  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.277210  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 3
05:22:38.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.282967  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.423388  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 4
05:22:38.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.428339  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.711774  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 5
05:22:38.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.716351  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:38.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:38.814201  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 6
05:22:38.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:38.821187  7967 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:39.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.947018  7980 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
05:22:39.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:37.948565  7982 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
05:22:39.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:37.949755  7969 server_base.cc:1034] running on GCE node
05:22:39.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.177182  7969 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:39.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.181210  7969 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:39.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.183130  7969 hybrid_clock.cc:648] HybridClock initialized: now 1783488159183045 us; error 94 us; skew 500 ppm
05:22:39.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.184654  7969 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:39.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.192858  7969 webserver.cc:460] Webserver started at http://127.7.161.60:46141/ using document root <none> and password file <none>
05:22:39.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.194090  7969 fs_manager.cc:359] Metadata directory not provided
05:22:39.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.194401  7969 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:39.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.195037  7969 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:39.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.205410  7969 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data/instance:
05:22:39.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a9e0b100b787492ea7aee620d0113e26"
05:22:39.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:39 on dist-test-slave-gttl"
05:22:39.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.207306  7969 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal/instance:
05:22:39.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a9e0b100b787492ea7aee620d0113e26"
05:22:39.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:39 on dist-test-slave-gttl"
05:22:39.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.218443  7969 fs_manager.cc:691] Time spent creating directory manager: real 0.010s	user 0.007s	sys 0.005s
05:22:39.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.226974  7993 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:39.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.228549  7969 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.005s	sys 0.000s
05:22:39.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.229197  7969 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal
05:22:39.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a9e0b100b787492ea7aee620d0113e26"
05:22:39.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:39 on dist-test-slave-gttl"
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.229739  7969 fs_report.cc:383] FS layout report
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data/data
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:39.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:39.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:39.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.268810  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 6
05:22:39.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:39.275647  7892 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.7.161.60:40177: Network error: Client connection negotiation failed: client connection to 127.7.161.60:40177: connect: Connection refused (error 111)
05:22:39.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.283015  7969 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:39.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.284495  7969 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
05:22:39.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.284936  7969 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.361047  7969 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.60:40177
05:22:39.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.361218  8046 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.60:40177 every 8 connection(s)
05:22:39.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.364943  7969 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/data/info.pb
05:22:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.371417  8047 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.372403  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 7969
05:22:39.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.372876  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/master-2/wal/instance
05:22:39.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.389400  8047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } has no permanent_uuid. Determining permanent_uuid...
05:22:39.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.418480  8047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } has no permanent_uuid. Determining permanent_uuid...
05:22:39.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.430639  8047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } has no permanent_uuid. Determining permanent_uuid...
05:22:39.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.448269  8047 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: Bootstrap starting.
05:22:39.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.454795  8047 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: Neither blocks nor log segments found. Creating new log.
05:22:39.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.457034  8047 log.cc:824] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: Log is configured to *not* fsync() on all Append() calls
05:22:39.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.462343  8047 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: No bootstrap required, opened a new log
05:22:39.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.483552  8047 raft_consensus.cc:348] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.484189  8047 raft_consensus.cc:374] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:39.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.484375  8047 raft_consensus.cc:729] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a9e0b100b787492ea7aee620d0113e26, State: Initialized, Role: FOLLOWER
05:22:39.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.485256  8047 consensus_queue.cc:260] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.487617  8056 sys_catalog.cc:455] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:39.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.488344  8056 sys_catalog.cc:458] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: This master's current role is: FOLLOWER
05:22:39.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.488929  8047 sys_catalog.cc:564] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: configured and running, proceeding with master startup.
05:22:39.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:39.518536  8067 catalog_manager.cc:1558] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
05:22:39.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:39.518911  8067 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
05:22:39.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:39.540443  8001 tablet.cc:2369] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: Can't schedule compaction. Clean time has not been advanced past its initial value.
05:22:39.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.513149  7969 master_runner.cc:186] Error getting master registration for 127.7.161.62:37979: OK, instance_id { permanent_uuid: "ff983c58368d4af494c163c20941ab46" instance_seqno: 1783488155641539 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
05:22:39.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.548689  7969 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
05:22:39.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.819281  8056 raft_consensus.cc:482] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
05:22:39.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.819825  8056 raft_consensus.cc:504] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.822110  8056 leader_election.cc:288] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers ff983c58368d4af494c163c20941ab46 (127.7.161.62:37979), e0ada1b2bd07439785f266ed6373d4bb (127.7.161.61:34521)
05:22:39.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.881829  7967 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 7
05:22:39.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.905738  7967 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: Bootstrap starting.
05:22:39.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.913673  7967 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: Neither blocks nor log segments found. Creating new log.
05:22:39.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.918792  7967 log.cc:824] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: Log is configured to *not* fsync() on all Append() calls
05:22:39.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.925300  7967 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: No bootstrap required, opened a new log
05:22:39.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.958123  7967 raft_consensus.cc:348] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.959053  7967 raft_consensus.cc:374] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:39.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.959318  7967 raft_consensus.cc:729] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e0ada1b2bd07439785f266ed6373d4bb, State: Initialized, Role: FOLLOWER
05:22:39.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.960263  7967 consensus_queue.cc:260] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.964006  8071 sys_catalog.cc:455] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:39.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.965656  7967 sys_catalog.cc:564] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: configured and running, proceeding with master startup.
05:22:39.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.965922  8071 sys_catalog.cc:458] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: This master's current role is: FOLLOWER
05:22:39.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.965865  7942 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a9e0b100b787492ea7aee620d0113e26" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e0ada1b2bd07439785f266ed6373d4bb" is_pre_election: true
05:22:39.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.967005  7942 raft_consensus.cc:2454] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a9e0b100b787492ea7aee620d0113e26 in term 0.
05:22:39.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.968598  7995 leader_election.cc:302] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [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: a9e0b100b787492ea7aee620d0113e26, e0ada1b2bd07439785f266ed6373d4bb; no voters: 
05:22:39.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.969635  8056 raft_consensus.cc:2781] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Leader pre-election won for term 1
05:22:39.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.969961  8056 raft_consensus.cc:482] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
05:22:39.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.970254  8056 raft_consensus.cc:3037] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 0 FOLLOWER]: Advancing to term 1
05:22:39.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.976779  8056 raft_consensus.cc:504] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:39.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.982117  7942 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a9e0b100b787492ea7aee620d0113e26" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e0ada1b2bd07439785f266ed6373d4bb"
05:22:39.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.982717  7942 raft_consensus.cc:3037] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 0 FOLLOWER]: Advancing to term 1
05:22:39.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.989614  8056 leader_election.cc:288] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [CANDIDATE]: Term 1 election: Requested vote from peers ff983c58368d4af494c163c20941ab46 (127.7.161.62:37979), e0ada1b2bd07439785f266ed6373d4bb (127.7.161.61:34521)
05:22:39.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:39.998646  7942 raft_consensus.cc:2454] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a9e0b100b787492ea7aee620d0113e26 in term 1.
05:22:40.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.000851  7995 leader_election.cc:302] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [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: a9e0b100b787492ea7aee620d0113e26, e0ada1b2bd07439785f266ed6373d4bb; no voters: 
05:22:40.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.002038  8056 raft_consensus.cc:2781] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 1 FOLLOWER]: Leader election won for term 1
05:22:40.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.013990  8056 raft_consensus.cc:686] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [term 1 LEADER]: Becoming Leader. State: Replica: a9e0b100b787492ea7aee620d0113e26, State: Running, Role: LEADER
05:22:40.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.016014  8056 consensus_queue.cc:237] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:40.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.042877  8084 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
05:22:40.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.044543  8079 sys_catalog.cc:455] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a9e0b100b787492ea7aee620d0113e26. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.045385  8079 sys_catalog.cc:458] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: This master's current role is: LEADER
05:22:40.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.048151  8085 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
05:22:40.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.056723  8085 catalog_manager.cc:1484] Initializing Kudu cluster ID...
05:22:40.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.079099  7942 raft_consensus.cc:1261] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [term 1 FOLLOWER]: Refusing update from remote peer a9e0b100b787492ea7aee620d0113e26: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
05:22:40.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.086011  8056 consensus_queue.cc:1035] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
05:22:40.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.046694  7894 master_runner.cc:186] Error getting master registration for 127.7.161.62:37979: OK, instance_id { permanent_uuid: "ff983c58368d4af494c163c20941ab46" instance_seqno: 1783488155641539 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
05:22:40.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.102667  7894 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
05:22:40.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.107402  8071 sys_catalog.cc:455] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: SysCatalogTable state changed. Reason: New leader a9e0b100b787492ea7aee620d0113e26. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.108217  8071 sys_catalog.cc:458] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: This master's current role is: FOLLOWER
05:22:40.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.113582  8079 sys_catalog.cc:455] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.114953  8079 sys_catalog.cc:458] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: This master's current role is: LEADER
05:22:40.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.117224  8085 catalog_manager.cc:1347] Generated new cluster ID: a74a093457864cd6a6fa9bebda2b19a1
05:22:40.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.117547  8085 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
05:22:40.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.118762  8087 mvcc.cc:205] Tried to move back new op lower bound from 7305167503656579072 to 7305167503441170432. Current Snapshot: MvccSnapshot[applied={T|T < 7305167503656579072}]
05:22:40.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.143651  8071 sys_catalog.cc:455] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.144487  8071 sys_catalog.cc:458] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb [sys.catalog]: This master's current role is: FOLLOWER
05:22:40.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.177294  8085 catalog_manager.cc:1370] Generated new certificate authority record
05:22:40.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.179952  8085 catalog_manager.cc:1504] Loading token signing keys...
05:22:40.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.205746  8085 catalog_manager.cc:5868] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26: Generated new TSK 0
05:22:40.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.206988  8085 catalog_manager.cc:1514] Initializing in-progress tserver states...
05:22:40.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.231348  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/logs
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data/info.pb
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:40.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.1:0
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.1
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.1
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:40.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
05:22:40.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.309058  7892 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } attempt: 7
05:22:40.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.346580  7892 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: Bootstrap starting.
05:22:40.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.362265  7892 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: Neither blocks nor log segments found. Creating new log.
05:22:40.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.367530  7892 log.cc:824] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: Log is configured to *not* fsync() on all Append() calls
05:22:40.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.379987  7892 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: No bootstrap required, opened a new log
05:22:40.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.415623  7892 raft_consensus.cc:348] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:40.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.417088  7892 raft_consensus.cc:374] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:40.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.417702  7892 raft_consensus.cc:729] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ff983c58368d4af494c163c20941ab46, State: Initialized, Role: FOLLOWER
05:22:40.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.419062  7892 consensus_queue.cc:260] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } }
05:22:40.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.444445  7892 sys_catalog.cc:564] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: configured and running, proceeding with master startup.
05:22:40.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.444582  7867 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a9e0b100b787492ea7aee620d0113e26" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ff983c58368d4af494c163c20941ab46" is_pre_election: true
05:22:40.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.445711  7865 raft_consensus.cc:3037] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [term 0 FOLLOWER]: Advancing to term 1
05:22:40.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.447212  7866 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a9e0b100b787492ea7aee620d0113e26" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ff983c58368d4af494c163c20941ab46"
05:22:40.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.443246  8094 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [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: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.449040  8094 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: This master's current role is: FOLLOWER
05:22:40.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.452505  7865 raft_consensus.cc:1261] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [term 1 FOLLOWER]: Refusing update from remote peer a9e0b100b787492ea7aee620d0113e26: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
05:22:40.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.461876  8079 consensus_queue.cc:1035] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [LEADER]: Connected to new peer: Peer: permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
05:22:40.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.520932  8094 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a9e0b100b787492ea7aee620d0113e26. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.521772  8094 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: This master's current role is: FOLLOWER
05:22:40.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.521116  8103 sys_catalog.cc:455] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.523943  8103 sys_catalog.cc:458] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46 [sys.catalog]: This master's current role is: FOLLOWER
05:22:40.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.547506  8111 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
05:22:40.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.716574  8091 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:40.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.717267  8091 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:40.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.718019  8091 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:40.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.756569  8091 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:40.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.757730  8091 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.161.1
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.794936  8091 tablet_server_runner.cc:78] Tablet server non-default flags:
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:40.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.1:0
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data/info.pb
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.1
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:40.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.1
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/logs
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:40.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:40.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.796165  8091 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:40.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.798192  8091 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:40.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.826056  8118 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
05:22:40.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.935760  8079 sys_catalog.cc:455] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a9e0b100b787492ea7aee620d0113e26" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "ff983c58368d4af494c163c20941ab46" member_type: VOTER last_known_addr { host: "127.7.161.62" port: 37979 } } peers { permanent_uuid: "e0ada1b2bd07439785f266ed6373d4bb" member_type: VOTER last_known_addr { host: "127.7.161.61" port: 34521 } } peers { permanent_uuid: "a9e0b100b787492ea7aee620d0113e26" member_type: VOTER last_known_addr { host: "127.7.161.60" port: 40177 } } }
05:22:40.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.938123  8079 sys_catalog.cc:458] T 00000000000000000000000000000000 P a9e0b100b787492ea7aee620d0113e26 [sys.catalog]: This master's current role is: LEADER
05:22:41.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.053352  8084 catalog_manager.cc:1259] Loaded cluster ID: a74a093457864cd6a6fa9bebda2b19a1
05:22:41.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.054016  8084 catalog_manager.cc:1552] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: loading cluster ID for follower catalog manager: success
05:22:41.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.062475  8084 catalog_manager.cc:1574] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: acquiring CA information for follower catalog manager: success
05:22:41.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.069244  8084 catalog_manager.cc:1602] T 00000000000000000000000000000000 P e0ada1b2bd07439785f266ed6373d4bb: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
05:22:41.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.579707  8111 catalog_manager.cc:1259] Loaded cluster ID: a74a093457864cd6a6fa9bebda2b19a1
05:22:41.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.580677  8111 catalog_manager.cc:1552] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: loading cluster ID for follower catalog manager: success
05:22:41.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.605106  8111 catalog_manager.cc:1574] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: acquiring CA information for follower catalog manager: success
05:22:41.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:41.614665  8111 catalog_manager.cc:1602] T 00000000000000000000000000000000 P ff983c58368d4af494c163c20941ab46: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
05:22:42.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:40.833217  8091 server_base.cc:1034] running on GCE node
05:22:42.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.832355  8120 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
05:22:42.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:40.830847  8117 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
05:22:42.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.330792  8091 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:42.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.334052  8091 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:42.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.336910  8091 hybrid_clock.cc:648] HybridClock initialized: now 1783488162336836 us; error 94 us; skew 500 ppm
05:22:42.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.338279  8091 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:42.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.376986  8091 webserver.cc:460] Webserver started at http://127.7.161.1:37467/ using document root <none> and password file <none>
05:22:42.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.378413  8091 fs_manager.cc:359] Metadata directory not provided
05:22:42.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.378752  8091 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:42.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.379390  8091 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:42.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.387493  8091 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data/instance:
05:22:42.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "185a7d3cf28344d6afb06225e1047ca5"
05:22:42.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:42 on dist-test-slave-gttl"
05:22:42.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.389248  8091 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal/instance:
05:22:42.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "185a7d3cf28344d6afb06225e1047ca5"
05:22:42.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:42 on dist-test-slave-gttl"
05:22:42.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.400537  8091 fs_manager.cc:691] Time spent creating directory manager: real 0.010s	user 0.009s	sys 0.000s
05:22:42.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.409309  8134 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:42.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.411250  8091 fs_manager.cc:725] Time spent opening block manager: real 0.006s	user 0.003s	sys 0.000s
05:22:42.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.411916  8091 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal
05:22:42.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "185a7d3cf28344d6afb06225e1047ca5"
05:22:42.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:42 on dist-test-slave-gttl"
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.412703  8091 fs_report.cc:383] FS layout report
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data/data
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:42.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:42.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:42.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:42.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:42.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:42.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.469237  8091 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:42.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.471653  8091 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
05:22:42.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.472514  8091 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:42.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.476275  8091 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
05:22:42.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.482896  8091 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
05:22:42.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.483474  8091 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.001s	user 0.001s	sys 0.000s
05:22:42.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.484007  8091 ts_tablet_manager.cc:610] Registered 0 tablets
05:22:42.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.484381  8091 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
05:22:42.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.761456  8091 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.1:43679
05:22:42.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.761586  8246 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.1:43679 every 8 connection(s)
05:22:42.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.764447  8091 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/data/info.pb
05:22:42.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.772643  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 8091
05:22:42.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.773149  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-0/wal/instance
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.787760  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:42.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/logs
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data/info.pb
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:42.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.2:0
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.2
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.2
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:42.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
05:22:42.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.869481  8247 heartbeater.cc:347] Connected to a master server at 127.7.161.61:34521
05:22:42.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.870226  8247 heartbeater.cc:464] Registering TS with master...
05:22:42.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.871661  8247 heartbeater.cc:511] Master 127.7.161.61:34521 requested a full tablet report, sending...
05:22:42.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.875685  7932 ts_manager.cc:194] Registered new tserver with Master: 185a7d3cf28344d6afb06225e1047ca5 (127.7.161.1:43679)
05:22:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.899971  8248 heartbeater.cc:347] Connected to a master server at 127.7.161.60:40177
05:22:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.900378  8248 heartbeater.cc:464] Registering TS with master...
05:22:42.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.901206  8248 heartbeater.cc:511] Master 127.7.161.60:40177 requested a full tablet report, sending...
05:22:42.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.904245  8012 ts_manager.cc:194] Registered new tserver with Master: 185a7d3cf28344d6afb06225e1047ca5 (127.7.161.1:43679)
05:22:42.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.908617  8252 heartbeater.cc:347] Connected to a master server at 127.7.161.62:37979
05:22:42.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.909017  8252 heartbeater.cc:464] Registering TS with master...
05:22:42.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.909691  8012 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.7.161.1:54801
05:22:42.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.909848  8252 heartbeater.cc:511] Master 127.7.161.62:37979 requested a full tablet report, sending...
05:22:42.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:42.913015  7857 ts_manager.cc:194] Registered new tserver with Master: 185a7d3cf28344d6afb06225e1047ca5 (127.7.161.1:43679)
05:22:43.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.261718  8251 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:43.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.262399  8251 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:43.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.263150  8251 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:43.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.318104  8251 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:43.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.319476  8251 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.161.2
05:22:43.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:43.380415  8251 tablet_server_runner.cc:78] Tablet server non-default flags:
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.2:0
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data/info.pb
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.2
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:43.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.2
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/logs
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:43.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:43.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:43.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:43.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:43.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:43.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:43.393821  8251 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:43.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:43.396641  8251 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:43.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.423353  8263 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
05:22:43.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:43.917938  8248 heartbeater.cc:503] Master 127.7.161.60:40177 was elected leader, sending a full tablet report...
05:22:45.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:44.817377  8262 debug-util.cc:398] Leaking SignalData structure 0x7b0800014860 after lost signal to thread 8251
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:45.384328  8262 kernel_stack_watchdog.cc:198] Thread 8251 stuck at /data0/somelongdirectorytoavoidrpathissues/src/kudu/src/kudu/util/thread.cc:637 for 390ms:
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:45.384687  8251 thread.cc:636] OpenStack (cloud detector) Time spent creating pthread: real 1.960s	user 0.001s	sys 0.001s
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:45.385102  8251 thread.cc:602] OpenStack (cloud detector) Time spent starting thread: real 1.960s	user 0.001s	sys 0.001s
05:22:45.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:43.423462  8264 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
05:22:45.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:45.385572  8265 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1960 milliseconds
05:22:45.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:45.387178  8266 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
05:22:45.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.387135  8251 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
05:22:45.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.390641  8251 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:45.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.393224  8251 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:45.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.394665  8251 hybrid_clock.cc:648] HybridClock initialized: now 1783488165394598 us; error 75 us; skew 500 ppm
05:22:45.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.395879  8251 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:45.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.403709  8251 webserver.cc:460] Webserver started at http://127.7.161.2:41947/ using document root <none> and password file <none>
05:22:45.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.404925  8251 fs_manager.cc:359] Metadata directory not provided
05:22:45.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.405234  8251 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:45.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.405754  8251 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:45.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.411873  8251 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data/instance:
05:22:45.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e1a0ab13a814c98adf0f83248a9594d"
05:22:45.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:45 on dist-test-slave-gttl"
05:22:45.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.412967  8251 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal/instance:
05:22:45.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e1a0ab13a814c98adf0f83248a9594d"
05:22:45.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:45 on dist-test-slave-gttl"
05:22:45.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.419936  8251 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
05:22:45.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.425457  8275 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:45.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.426535  8251 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
05:22:45.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.426959  8251 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal
05:22:45.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6e1a0ab13a814c98adf0f83248a9594d"
05:22:45.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:45 on dist-test-slave-gttl"
05:22:45.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.427330  8251 fs_report.cc:383] FS layout report
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data/data
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:45.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:45.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.469527  8251 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:45.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.471078  8251 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
05:22:45.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.471613  8251 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:45.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.474325  8251 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
05:22:45.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.478703  8251 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
05:22:45.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.478950  8251 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
05:22:45.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.479310  8251 ts_tablet_manager.cc:610] Registered 0 tablets
05:22:45.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.479506  8251 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
05:22:45.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.636605  8251 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.2:34831
05:22:45.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.636705  8387 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.2:34831 every 8 connection(s)
05:22:45.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.639264  8251 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/data/info.pb
05:22:45.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.648284  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 8251
05:22:45.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.649163  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-1/wal/instance
05:22:45.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.675287  7812 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:45.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/logs
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data/info.pb
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.3:0
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.3
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.3
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:45.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:45.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:45.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
05:22:45.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.699687  8388 heartbeater.cc:347] Connected to a master server at 127.7.161.61:34521
05:22:45.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.700186  8388 heartbeater.cc:464] Registering TS with master...
05:22:45.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.700975  8389 heartbeater.cc:347] Connected to a master server at 127.7.161.60:40177
05:22:45.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.701373  8389 heartbeater.cc:464] Registering TS with master...
05:22:45.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.701478  8388 heartbeater.cc:511] Master 127.7.161.61:34521 requested a full tablet report, sending...
05:22:45.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.702306  8389 heartbeater.cc:511] Master 127.7.161.60:40177 requested a full tablet report, sending...
05:22:45.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.705506  7932 ts_manager.cc:194] Registered new tserver with Master: 6e1a0ab13a814c98adf0f83248a9594d (127.7.161.2:34831)
05:22:45.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.707401  8012 ts_manager.cc:194] Registered new tserver with Master: 6e1a0ab13a814c98adf0f83248a9594d (127.7.161.2:34831)
05:22:45.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.709582  8012 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.7.161.2:54057
05:22:45.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.712692  8390 heartbeater.cc:347] Connected to a master server at 127.7.161.62:37979
05:22:45.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.713035  8390 heartbeater.cc:464] Registering TS with master...
05:22:45.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.714812  8390 heartbeater.cc:511] Master 127.7.161.62:37979 requested a full tablet report, sending...
05:22:45.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:45.717536  7857 ts_manager.cc:194] Registered new tserver with Master: 6e1a0ab13a814c98adf0f83248a9594d (127.7.161.2:34831)
05:22:46.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.014977  8398 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
05:22:46.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.015570  8398 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
05:22:46.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.016201  8398 flags.cc:425] Enabled unsafe flag: --never_fsync=true
05:22:46.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.048447  8398 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
05:22:46.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.049559  8398 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.161.3
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:46.086616  8398 tablet_server_runner.cc:78] Tablet server non-default flags:
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.161.20:40253
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.161.3:0
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data/info.pb
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.161.3
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.161.62:37979,127.7.161.61:34521,127.7.161.60:40177
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
05:22:46.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.161.3
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/logs
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 04:09:51 UTC on ccycloud.quasar-cakjni.root.comops.site
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492623
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
05:22:46.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:46.088267  8398 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
05:22:46.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:46.090274  8398 file_cache.cc:493] Constructed file cache file cache with capacity 419430
05:22:46.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.109961  8408 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
05:22:46.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:46.715916  8389 heartbeater.cc:503] Master 127.7.161.60:40177 was elected leader, sending a full tablet report...
05:22:47.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.110080  8405 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
05:22:47.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:46.111961  8398 server_base.cc:1034] running on GCE node
05:22:47.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:46.110164  8406 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
05:22:47.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.334560  8398 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
05:22:47.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.338240  8398 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
05:22:47.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.339738  8398 hybrid_clock.cc:648] HybridClock initialized: now 1783488167339699 us; error 56 us; skew 500 ppm
05:22:47.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.340569  8398 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
05:22:47.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.347999  8398 webserver.cc:460] Webserver started at http://127.7.161.3:44063/ using document root <none> and password file <none>
05:22:47.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.349125  8398 fs_manager.cc:359] Metadata directory not provided
05:22:47.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.349354  8398 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
05:22:47.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.349902  8398 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
05:22:47.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.355147  8398 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data/instance:
05:22:47.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d1510c053f44740804462c65f860435"
05:22:47.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:47 on dist-test-slave-gttl"
05:22:47.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.356662  8398 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal/instance:
05:22:47.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d1510c053f44740804462c65f860435"
05:22:47.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:47 on dist-test-slave-gttl"
05:22:47.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.365614  8398 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.002s	sys 0.005s
05:22:47.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.372582  8415 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
05:22:47.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.374010  8398 fs_manager.cc:725] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.000s
05:22:47.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.374450  8398 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data,/tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal
05:22:47.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d1510c053f44740804462c65f860435"
05:22:47.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 05:22:47 on dist-test-slave-gttl"
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.374902  8398 fs_report.cc:383] FS layout report
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data/data
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
05:22:47.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
05:22:47.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.427628  8398 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
05:22:47.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.429141  8398 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
05:22:47.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.429582  8398 kserver.cc:163] Server-wide thread pool size limit: 3276
05:22:47.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.432140  8398 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
05:22:47.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.436244  8398 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
05:22:47.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.436573  8398 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
05:22:47.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.436923  8398 ts_tablet_manager.cc:610] Registered 0 tablets
05:22:47.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.437141  8398 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.001s	sys 0.000s
05:22:47.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.590499  8398 rpc_server.cc:307] RPC server started. Bound to: 127.7.161.3:43107
05:22:47.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.590687  8527 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.161.3:43107 every 8 connection(s)
05:22:47.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.593451  8398 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/data/info.pb
05:22:47.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.601032  7812 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu as pid 8398
05:22:47.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.601661  7812 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskjRUvUo/test-tmp/mini-kudu-cluster4548050934760296482/ts-2/wal/instance
05:22:47.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.655050  8528 heartbeater.cc:347] Connected to a master server at 127.7.161.61:34521
05:22:47.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.655615  8528 heartbeater.cc:464] Registering TS with master...
05:22:47.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.656184  8529 heartbeater.cc:347] Connected to a master server at 127.7.161.60:40177
05:22:47.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.656522  8529 heartbeater.cc:464] Registering TS with master...
05:22:47.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.656903  8528 heartbeater.cc:511] Master 127.7.161.61:34521 requested a full tablet report, sending...
05:22:47.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.657604  8529 heartbeater.cc:511] Master 127.7.161.60:40177 requested a full tablet report, sending...
05:22:47.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.658259  8530 heartbeater.cc:347] Connected to a master server at 127.7.161.62:37979
05:22:47.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.658607  8530 heartbeater.cc:464] Registering TS with master...
05:22:47.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.659423  8530 heartbeater.cc:511] Master 127.7.161.62:37979 requested a full tablet report, sending...
05:22:47.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.660276  8012 ts_manager.cc:194] Registered new tserver with Master: 7d1510c053f44740804462c65f860435 (127.7.161.3:43107)
05:22:47.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.660193  7932 ts_manager.cc:194] Registered new tserver with Master: 7d1510c053f44740804462c65f860435 (127.7.161.3:43107)
05:22:47.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.662273  8012 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.7.161.3:56817
05:22:47.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.666889  7857 ts_manager.cc:194] Registered new tserver with Master: 7d1510c053f44740804462c65f860435 (127.7.161.3:43107)
05:22:47.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:47.675616  7812 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
05:22:47.688 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
05:22:47.689 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

05:22:47.703 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.161.62"
      port: 37979
    }
    bound_http_address {
      host: "127.7.161.62"
      port: 39883
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.161.61"
      port: 34521
    }
    bound_http_address {
      host: "127.7.161.61"
      port: 39033
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.161.60"
      port: 40177
    }
    bound_http_address {
      host: "127.7.161.60"
      port: 46141
    }
  }
}

05:22:47.709 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

05:22:47.711 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.161.1"
      port: 43679
    }
    bound_http_address {
      host: "127.7.161.1"
      port: 37467
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.161.2"
      port: 34831
    }
    bound_http_address {
      host: "127.7.161.2"
      port: 41947
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.161.3"
      port: 43107
    }
    bound_http_address {
      host: "127.7.161.3"
      port: 44063
    }
  }
}

05:22:47.712 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
05:22:47.907 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
05:22:48.092 [DEBUG - main] (Connection.java:748) [peer master-127.7.161.60:40177(127.7.161.60:40177)] connecting to peer
05:22:48.150 [DEBUG - main] (Connection.java:748) [peer master-127.7.161.61:34521(127.7.161.61:34521)] connecting to peer
05:22:48.152 [DEBUG - main] (Connection.java:748) [peer master-127.7.161.62:37979(127.7.161.62:37979)] connecting to peer
05:22:48.189 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.161.61:34521(127.7.161.61:34521)] Successfully connected to peer
05:22:48.194 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.161.60:40177(127.7.161.60:40177)] Successfully connected to peer
05:22:48.268 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.161.62:37979(127.7.161.62:37979)] Successfully connected to peer
05:22:48.296 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.7.161.61
05:22:48.299 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.7.161.60
05:22:48.407 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.7.161.62
05:22:48.541 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xdeac1cb9, L:/127.0.0.1:59974 - R:/127.7.161.62:37979] using SASL/PLAIN
05:22:48.541 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xb9afdc94, L:/127.0.0.1:50410 - R:/127.7.161.61:34521] using SASL/PLAIN
05:22:48.558 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x6c64f9a0, L:/127.0.0.1:57760 - R:/127.7.161.60:40177] using SASL/PLAIN
05:22:48.591 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
05:22:48.593 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=543), Traces: [0ms] refreshing cache from master, [30ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.161.60:40177, [97ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.161.61:34521, [98ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.161.62:37979, [502ms] Sub RPC ConnectToMaster: received response from server master-127.7.161.62:37979: OK, [502ms] Sub RPC ConnectToMaster: received response from server master-127.7.161.61:34521: OK, [512ms] Sub RPC ConnectToMaster: received response from server master-127.7.161.60:40177: OK, deferred=null) after lookup
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.652541  8012 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:57760:
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783488153265"
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
05:22:48.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
05:22:48.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
05:22:48.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:48.655572  8012 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-1783488153265 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
05:22:48.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.666378  8529 heartbeater.cc:503] Master 127.7.161.60:40177 was elected leader, sending a full tablet report...
05:22:48.738 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 440da40dd5f345d5af5951ed561071e7
05:22:48.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.779562  8463 tablet_service.cc:1467] Processing CreateTablet for tablet 96c3063d698d49dab20a6dd5bc5a64c9 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783488153265 [id=440da40dd5f345d5af5951ed561071e7]), partition=RANGE (key) PARTITION UNBOUNDED
05:22:48.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.781646  8463 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 96c3063d698d49dab20a6dd5bc5a64c9. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:48.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.782593  8323 tablet_service.cc:1467] Processing CreateTablet for tablet 96c3063d698d49dab20a6dd5bc5a64c9 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783488153265 [id=440da40dd5f345d5af5951ed561071e7]), partition=RANGE (key) PARTITION UNBOUNDED
05:22:48.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.784515  8323 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 96c3063d698d49dab20a6dd5bc5a64c9. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:48.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.791432  8182 tablet_service.cc:1467] Processing CreateTablet for tablet 96c3063d698d49dab20a6dd5bc5a64c9 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783488153265 [id=440da40dd5f345d5af5951ed561071e7]), partition=RANGE (key) PARTITION UNBOUNDED
05:22:48.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.793814  8182 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 96c3063d698d49dab20a6dd5bc5a64c9. 1 dirs total, 0 dirs full, 0 dirs failed
05:22:48.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.808708  8564 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Bootstrap starting.
05:22:48.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.817044  8564 tablet_bootstrap.cc:654] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Neither blocks nor log segments found. Creating new log.
05:22:48.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.817014  8565 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Bootstrap starting.
05:22:48.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.819438  8564 log.cc:824] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Log is configured to *not* fsync() on all Append() calls
05:22:48.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.822654  8566 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Bootstrap starting.
05:22:48.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.824515  8565 tablet_bootstrap.cc:654] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Neither blocks nor log segments found. Creating new log.
05:22:48.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.826748  8564 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: No bootstrap required, opened a new log
05:22:48.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.826773  8565 log.cc:824] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Log is configured to *not* fsync() on all Append() calls
05:22:48.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.827298  8564 ts_tablet_manager.cc:1397] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Time spent bootstrapping tablet: real 0.019s	user 0.004s	sys 0.011s
05:22:48.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.829283  8566 tablet_bootstrap.cc:654] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Neither blocks nor log segments found. Creating new log.
05:22:48.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.831193  8566 log.cc:824] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Log is configured to *not* fsync() on all Append() calls
05:22:48.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.832113  8565 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: No bootstrap required, opened a new log
05:22:48.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.832624  8565 ts_tablet_manager.cc:1397] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Time spent bootstrapping tablet: real 0.016s	user 0.008s	sys 0.005s
05:22:48.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.838541  8566 tablet_bootstrap.cc:492] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: No bootstrap required, opened a new log
05:22:48.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.839082  8566 ts_tablet_manager.cc:1397] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Time spent bootstrapping tablet: real 0.017s	user 0.013s	sys 0.000s
05:22:48.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.858937  8565 raft_consensus.cc:348] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.859663  8565 raft_consensus.cc:374] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:48.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.859963  8565 raft_consensus.cc:729] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7d1510c053f44740804462c65f860435, State: Initialized, Role: FOLLOWER
05:22:48.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.860882  8565 consensus_queue.cc:260] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [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: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.862264  8564 raft_consensus.cc:348] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.863196  8564 raft_consensus.cc:374] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:48.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.863477  8564 raft_consensus.cc:729] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6e1a0ab13a814c98adf0f83248a9594d, State: Initialized, Role: FOLLOWER
05:22:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.864408  8564 consensus_queue.cc:260] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [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: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.866344  8565 ts_tablet_manager.cc:1428] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Time spent starting tablet: real 0.033s	user 0.031s	sys 0.000s
05:22:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.871429  8566 raft_consensus.cc:348] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.872386  8566 raft_consensus.cc:374] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
05:22:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.872706  8566 raft_consensus.cc:729] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 185a7d3cf28344d6afb06225e1047ca5, State: Initialized, Role: FOLLOWER
05:22:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.873688  8566 consensus_queue.cc:260] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [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: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:48.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:48.881100  8535 tablet.cc:2369] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435: Can't schedule compaction. Clean time has not been advanced past its initial value.
05:22:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.883608  8566 ts_tablet_manager.cc:1428] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Time spent starting tablet: real 0.044s	user 0.036s	sys 0.004s
05:22:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.886402  8564 ts_tablet_manager.cc:1428] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Time spent starting tablet: real 0.059s	user 0.038s	sys 0.005s
05:22:48.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:48.944628  8397 tablet.cc:2369] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d: Can't schedule compaction. Clean time has not been advanced past its initial value.
05:22:48.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.998790  8572 raft_consensus.cc:482] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
05:22:48.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:48.999264  8572 raft_consensus.cc:504] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:49.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.001766  8572 leader_election.cc:288] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 6e1a0ab13a814c98adf0f83248a9594d (127.7.161.2:34831), 7d1510c053f44740804462c65f860435 (127.7.161.3:43107)
05:22:49.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.004736  8571 raft_consensus.cc:482] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
05:22:49.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.005506  8571 raft_consensus.cc:504] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:49.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.008829  8571 leader_election.cc:288] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 7d1510c053f44740804462c65f860435 (127.7.161.3:43107), 185a7d3cf28344d6afb06225e1047ca5 (127.7.161.1:43679)
05:22:49.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.027668  8343 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "185a7d3cf28344d6afb06225e1047ca5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6e1a0ab13a814c98adf0f83248a9594d" is_pre_election: true
05:22:49.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.028600  8343 raft_consensus.cc:2454] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 185a7d3cf28344d6afb06225e1047ca5 in term 0.
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.030253  8136 leader_election.cc:302] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [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: 185a7d3cf28344d6afb06225e1047ca5, 6e1a0ab13a814c98adf0f83248a9594d; no voters: 
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.031284  8572 raft_consensus.cc:2781] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Leader pre-election won for term 1
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.031739  8572 raft_consensus.cc:482] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.032127  8572 raft_consensus.cc:3037] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 0 FOLLOWER]: Advancing to term 1
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.031924  8483 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "185a7d3cf28344d6afb06225e1047ca5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7d1510c053f44740804462c65f860435" is_pre_election: true
05:22:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.032878  8483 raft_consensus.cc:2454] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 185a7d3cf28344d6afb06225e1047ca5 in term 0.
05:22:49.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.039754  8572 raft_consensus.cc:504] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:49.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.040978  8483 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "6e1a0ab13a814c98adf0f83248a9594d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7d1510c053f44740804462c65f860435" is_pre_election: true
05:22:49.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.041618  8483 raft_consensus.cc:2454] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6e1a0ab13a814c98adf0f83248a9594d in term 0.
05:22:49.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.042709  8343 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "185a7d3cf28344d6afb06225e1047ca5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6e1a0ab13a814c98adf0f83248a9594d"
05:22:49.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.042843  8483 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "185a7d3cf28344d6afb06225e1047ca5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7d1510c053f44740804462c65f860435"
05:22:49.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.043195  8343 raft_consensus.cc:3037] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 0 FOLLOWER]: Advancing to term 1
05:22:49.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.043407  8483 raft_consensus.cc:3037] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 0 FOLLOWER]: Advancing to term 1
05:22:49.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.043565  8572 leader_election.cc:288] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [CANDIDATE]: Term 1 election: Requested vote from peers 6e1a0ab13a814c98adf0f83248a9594d (127.7.161.2:34831), 7d1510c053f44740804462c65f860435 (127.7.161.3:43107)
05:22:49.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.043048  8276 leader_election.cc:302] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [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: 6e1a0ab13a814c98adf0f83248a9594d, 7d1510c053f44740804462c65f860435; no voters: 
05:22:49.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.048894  8202 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "96c3063d698d49dab20a6dd5bc5a64c9" candidate_uuid: "6e1a0ab13a814c98adf0f83248a9594d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "185a7d3cf28344d6afb06225e1047ca5" is_pre_election: true
05:22:49.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.049677  8343 raft_consensus.cc:2454] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 185a7d3cf28344d6afb06225e1047ca5 in term 1.
05:22:49.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.050055  8202 raft_consensus.cc:2379] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 1 FOLLOWER]: Leader pre-election vote request: Denying vote to candidate 6e1a0ab13a814c98adf0f83248a9594d in current term 1: Already voted for candidate 185a7d3cf28344d6afb06225e1047ca5 in this term.
05:22:49.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.050144  8571 raft_consensus.cc:2741] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 1 FOLLOWER]: Leader pre-election decision vote started in defunct term 0: won
05:22:49.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.050100  8483 raft_consensus.cc:2454] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 185a7d3cf28344d6afb06225e1047ca5 in term 1.
05:22:49.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.051561  8135 leader_election.cc:302] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [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: 185a7d3cf28344d6afb06225e1047ca5, 7d1510c053f44740804462c65f860435; no voters: 
05:22:49.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.052368  8572 raft_consensus.cc:2781] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 1 FOLLOWER]: Leader election won for term 1
05:22:49.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.054801  8572 raft_consensus.cc:686] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [term 1 LEADER]: Becoming Leader. State: Replica: 185a7d3cf28344d6afb06225e1047ca5, State: Running, Role: LEADER
05:22:49.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.056496  8572 consensus_queue.cc:237] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [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: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } }
05:22:49.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.070236  8012 catalog_manager.cc:5495] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 reported cstate change: term changed from 0 to 1, leader changed from <none> to 185a7d3cf28344d6afb06225e1047ca5 (127.7.161.1). New cstate: current_term: 1 leader_uuid: "185a7d3cf28344d6afb06225e1047ca5" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "185a7d3cf28344d6afb06225e1047ca5" member_type: VOTER last_known_addr { host: "127.7.161.1" port: 43679 } health_report { overall_health: HEALTHY } } }
05:22:49.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 05:22:49.126312  8257 tablet.cc:2369] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5: Can't schedule compaction. Clean time has not been advanced past its initial value.
05:22:49.316 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 96c3063d698d49dab20a6dd5bc5a64c9 for table 'org.apache.kudu.client.TestHybridTime-1783488153265' with partition [<start>, <end>)
05:22:49.323 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=96c3063d698d49dab20a6dd5bc5a64c9@[185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)[L],6e1a0ab13a814c98adf0f83248a9594d(127.7.161.2:34831),7d1510c053f44740804462c65f860435(127.7.161.3:43107)]}]
05:22:49.324 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=20), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.161.60:40177, [10ms] Sub RPC GetTableLocations: received response from server master-127.7.161.60:40177: OK, deferred=null) after lookup
05:22:49.334 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)] connecting to peer
05:22:49.336 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)] Successfully connected to peer
05:22:49.405 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x296fb779, L:/127.0.0.1:38924 - R:/127.7.161.1:43679] using TOKEN/null
05:22:49.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.421037  8483 raft_consensus.cc:1261] T 96c3063d698d49dab20a6dd5bc5a64c9 P 7d1510c053f44740804462c65f860435 [term 1 FOLLOWER]: Refusing update from remote peer 185a7d3cf28344d6afb06225e1047ca5: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
05:22:49.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.421516  8343 raft_consensus.cc:1261] T 96c3063d698d49dab20a6dd5bc5a64c9 P 6e1a0ab13a814c98adf0f83248a9594d [term 1 FOLLOWER]: Refusing update from remote peer 185a7d3cf28344d6afb06225e1047ca5: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
05:22:49.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.422746  8572 consensus_queue.cc:1035] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7d1510c053f44740804462c65f860435" member_type: VOTER last_known_addr { host: "127.7.161.3" port: 43107 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
05:22:49.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.424155  8578 consensus_queue.cc:1035] T 96c3063d698d49dab20a6dd5bc5a64c9 P 185a7d3cf28344d6afb06225e1047ca5 [LEADER]: Connected to new peer: Peer: permanent_uuid: "6e1a0ab13a814c98adf0f83248a9594d" member_type: VOTER last_known_addr { host: "127.7.161.2" port: 34831 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
05:22:49.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.446193  8581 mvcc.cc:205] Tried to move back new op lower bound from 7305167541933195264 to 7305167540463747072. Current Snapshot: MvccSnapshot[applied={T|T < 7305167541933195264}]
05:22:49.532 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.559 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.580 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.585 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@832843255(state=PENDING, result=null, callback=<none>, errback=<none>)}
05:22:49.612 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.612 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@247184166(state=PENDING, result=null, callback=<none>, errback=<none>)}
05:22:49.632 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.634 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1635003755(state=PENDING, result=null, callback=<none>, errback=<none>)}
05:22:49.662 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
05:22:49.727 [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-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.738 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305167562413195265) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.749 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305167562413195270) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.759 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305167562413195274) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.773 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305167562413195278) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.786 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305167562413195282) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.800 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305167562413195288) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.814 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305167562413195289) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783488153265, tablet=96c3063d698d49dab20a6dd5bc5a64c9, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
05:22:49.819 [DEBUG - main] (Connection.java:575) [peer master-127.7.161.62:37979(127.7.161.62:37979)] disconnecting while in state READY
05:22:49.820 [DEBUG - main] (Connection.java:575) [peer master-127.7.161.60:40177(127.7.161.60:40177)] disconnecting while in state READY
05:22:49.820 [DEBUG - main] (Connection.java:575) [peer 185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)] disconnecting while in state READY
05:22:49.821 [DEBUG - main] (Connection.java:575) [peer master-127.7.161.61:34521(127.7.161.61:34521)] disconnecting while in state READY
05:22:49.831 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
05:22:49.832 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.161.62:37979(127.7.161.62:37979)] handling channelInactive
05:22:49.833 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)] handling channelInactive
05:22:49.833 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 185a7d3cf28344d6afb06225e1047ca5(127.7.161.1:43679)] cleaning up while in state READY due to: connection closed
05:22:49.833 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.161.62:37979(127.7.161.62:37979)] cleaning up while in state READY due to: connection closed
05:22:49.834 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.161.61:34521(127.7.161.61:34521)] handling channelInactive
05:22:49.834 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.161.60:40177(127.7.161.60:40177)] handling channelInactive
05:22:49.834 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.161.61:34521(127.7.161.61:34521)] cleaning up while in state READY due to: connection closed
05:22:49.834 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.161.60:40177(127.7.161.60:40177)] cleaning up while in state READY due to: connection closed
05:22:49.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.835320  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 8091
05:22:49.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.866132  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 8251
05:22:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.892596  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 8398
05:22:49.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.920785  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 7824
05:22:49.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.948237  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 7894
05:22:49.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 05:22:49.974465  7812 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskjRUvUo/build/tsan/bin/kudu with pid 7969
05:22:51.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T05:22:51Z chronyd exiting

Time: 19.154

OK (1 test)

