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

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

16:15:30.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.747848  4841 mini_oidc.cc:152] Starting JWKS server
16:15:30.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.751221  4841 webserver.cc:460] Webserver started at http://127.0.0.1:44781/ using document root <none> and password file <none>
16:15:30.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.751822  4841 mini_oidc.cc:189] Starting OIDC Discovery server
16:15:30.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.754316  4841 webserver.cc:460] Webserver started at http://127.0.0.1:43195/ using document root <none> and password file <none>
16:15:30.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:30Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
16:15:30.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:30Z Disabled control of system clock
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:30.802815  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:30.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/logs
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data/info.pb
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:30.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:30.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.126:41685
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.126
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:30.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:30.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:30.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:30.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:30.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json with env {}
16:15:31.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.090273  4864 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:31.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.090929  4864 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:31.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.091485  4864 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:31.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.122138  4864 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:31.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.122404  4864 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:31.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.122601  4864 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:31.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.122856  4864 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:31.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.123099  4864 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:31.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.123245  4864 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44781/jwks.json
16:15:31.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.155300  4864 master_runner.cc:386] Master server non-default flags:
16:15:31.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:31.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:31.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:31.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:31.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.126:41685
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:31.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data/info.pb
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.126
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:31.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/logs
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:31.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:31.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:31.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:31.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.156419  4864 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:31.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.158067  4864 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:31.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.174456  4874 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:32.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.174489  4875 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:32.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:31.176702  4864 server_base.cc:1034] running on GCE node
16:15:32.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:31.174698  4878 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:32.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.316892  4864 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:32.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.319530  4864 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:32.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.320880  4864 hybrid_clock.cc:648] HybridClock initialized: now 1786464932320891 us; error 85 us; skew 500 ppm
16:15:32.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.321650  4864 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:32.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.327818  4864 webserver.cc:460] Webserver started at http://127.4.186.126:34593/ using document root <none> and password file <none>
16:15:32.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.328689  4864 fs_manager.cc:359] Metadata directory not provided
16:15:32.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.328850  4864 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:32.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.329273  4864 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:32.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.333873  4864 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data/instance:
16:15:32.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e29b60e29477430cb71b47c9c0f08317"
16:15:32.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-39l8"
16:15:32.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.335021  4864 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal/instance:
16:15:32.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e29b60e29477430cb71b47c9c0f08317"
16:15:32.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-39l8"
16:15:32.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.341468  4864 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
16:15:32.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.346810  4888 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:32.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.347816  4864 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
16:15:32.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.348114  4864 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal
16:15:32.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e29b60e29477430cb71b47c9c0f08317"
16:15:32.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:32 on dist-test-slave-39l8"
16:15:32.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.348480  4864 fs_report.cc:383] FS layout report
16:15:32.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:32.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data/data
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:32.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:32.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:32.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.385140  4864 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:32.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.386772  4864 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:32.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.387156  4864 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:32.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.455024  4864 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.126:41685
16:15:32.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.455134  4969 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.126:41685 every 8 connection(s)
16:15:32.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.457665  4864 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/data/info.pb
16:15:32.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.460940  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 4864
16:15:32.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.461496  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-0/wal/instance
16:15:32.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.463858  4970 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:32.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.465298  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:32.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:32.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/logs
16:15:32.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data/info.pb
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:32.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.125:38747
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.125
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:32.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:32.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json with env {}
16:15:32.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.476636  4970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } has no permanent_uuid. Determining permanent_uuid...
16:15:32.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.504029  4970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } has no permanent_uuid. Determining permanent_uuid...
16:15:32.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.506234  4890 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:32.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.509843  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:32.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.559284  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 1
16:15:32.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.562907  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:32.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.631315  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 2
16:15:32.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.635286  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:32.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.726783  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 3
16:15:32.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.730288  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:32.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.765677  4972 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:32.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.766170  4972 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:32.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.766739  4972 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.795924  4972 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.796180  4972 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.796368  4972 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.796540  4972 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.796736  4972 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:32.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.796870  4972 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44781/jwks.json
16:15:32.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.828097  4972 master_runner.cc:386] Master server non-default flags:
16:15:32.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:32.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:32.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.125:38747
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:32.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data/info.pb
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.125
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/logs
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:32.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:32.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:32.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:32.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.829282  4972 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:32.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.830813  4972 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:32.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.847448  4991 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:32.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.873646  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 4
16:15:32.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.878021  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:33.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.177497  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 5
16:15:33.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.181596  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:33.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:33.729009  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 6
16:15:33.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:33.736361  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.125:38747: Network error: Client connection negotiation failed: client connection to 127.4.186.125:38747: connect: Connection refused (error 111)
16:15:34.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:32.849743  4972 server_base.cc:1034] running on GCE node
16:15:34.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.847510  4989 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:34.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:32.847679  4994 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:34.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.024128  4972 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:34.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.027370  4972 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:34.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.028793  4972 hybrid_clock.cc:648] HybridClock initialized: now 1786464934028752 us; error 60 us; skew 500 ppm
16:15:34.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.029815  4972 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:34.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.037576  4972 webserver.cc:460] Webserver started at http://127.4.186.125:46565/ using document root <none> and password file <none>
16:15:34.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.038689  4972 fs_manager.cc:359] Metadata directory not provided
16:15:34.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.038978  4972 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:34.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.039541  4972 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:34.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.045038  4972 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data/instance:
16:15:34.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f1612a72ad404244a4b38ec629ff03f7"
16:15:34.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-39l8"
16:15:34.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.046205  4972 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal/instance:
16:15:34.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f1612a72ad404244a4b38ec629ff03f7"
16:15:34.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-39l8"
16:15:34.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.053022  4972 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.001s	sys 0.004s
16:15:34.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.058244  5006 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:34.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.059278  4972 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.002s
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.059619  4972 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f1612a72ad404244a4b38ec629ff03f7"
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:34 on dist-test-slave-39l8"
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.059975  4972 fs_report.cc:383] FS layout report
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal
16:15:34.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal
16:15:34.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data/data
16:15:34.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:34.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:34.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:34.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.104687  4972 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:34.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.106268  4972 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:34.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.106863  4972 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:34.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.177383  4972 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.125:38747
16:15:34.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.177477  5091 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.125:38747 every 8 connection(s)
16:15:34.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.180297  4972 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/data/info.pb
16:15:34.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.185082  5092 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:34.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.186460  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 4972
16:15:34.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.186858  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-1/wal/instance
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.188736  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/logs
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data/info.pb
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:34.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.124:42813
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.124
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:34.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:34.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:34.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:34.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json with env {}
16:15:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.199352  5092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.227205  5092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.242511  5092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.244629  5010 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.249781  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.299248  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 1
16:15:34.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.303081  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.371526  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 2
16:15:34.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.375321  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.466740  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 3
16:15:34.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.472925  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.503757  5099 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:34.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.504412  5099 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:34.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.505096  5099 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:34.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.534209  5099 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
16:15:34.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.534597  5099 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:34.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.534966  5099 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
16:15:34.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.535331  5099 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
16:15:34.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.535629  5099 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
16:15:34.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.535929  5099 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:44781/jwks.json
16:15:34.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.570225  5099 master_runner.cc:386] Master server non-default flags:
16:15:34.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.124:42813
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
16:15:34.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44781/jwks.json
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data/info.pb
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.124
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/logs
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:34.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:34.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.571784  5099 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:34.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.574038  5099 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:34.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.592707  5121 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:34.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.616449  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 4
16:15:34.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.620690  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.796960  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } attempt: 7
16:15:34.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.812579  4970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } has no permanent_uuid. Determining permanent_uuid...
16:15:34.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.817447  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.875820  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 1
16:15:34.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.880002  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.920154  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 5
16:15:34.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.924408  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:34.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:34.961459  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 2
16:15:34.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.965734  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:35.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.051376  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 3
16:15:35.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.055090  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:35.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.195708  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 4
16:15:35.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.199671  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:35.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.471781  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 6
16:15:35.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.479586  5092 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:35.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.483259  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 5
16:15:35.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.486792  4970 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.4.186.124:42813: Network error: Client connection negotiation failed: client connection to 127.4.186.124:42813: connect: Connection refused (error 111)
16:15:35.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.592760  5127 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:35.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:34.593784  5120 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:35.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:35.747038  5124 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
16:15:35.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.747174  5099 server_base.cc:1029] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
16:15:35.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.751653  5099 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:35.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.754587  5099 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:35.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.756035  5099 hybrid_clock.cc:648] HybridClock initialized: now 1786464935756030 us; error 76 us; skew 500 ppm
16:15:35.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.756770  5099 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:35.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.762845  5099 webserver.cc:460] Webserver started at http://127.4.186.124:42487/ using document root <none> and password file <none>
16:15:35.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.763743  5099 fs_manager.cc:359] Metadata directory not provided
16:15:35.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.763911  5099 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:35.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.764288  5099 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:35.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.770143  5099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data/instance:
16:15:35.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b2e6d8f29bb14db0932aa3af176770d3"
16:15:35.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-39l8"
16:15:35.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.771232  5099 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal/instance:
16:15:35.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b2e6d8f29bb14db0932aa3af176770d3"
16:15:35.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-39l8"
16:15:35.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.778163  5099 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
16:15:35.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.784196  5145 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:35.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.785425  5099 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.785802  5099 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b2e6d8f29bb14db0932aa3af176770d3"
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:35 on dist-test-slave-39l8"
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.786230  5099 fs_report.cc:383] FS layout report
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data/data
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:35.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:35.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:35.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.823545  5099 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:35.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.824966  5099 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:35.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.825357  5099 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:35.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.894766  5099 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.124:42813
16:15:35.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.894938  5223 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.124:42813 every 8 connection(s)
16:15:35.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.897192  5099 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/data/info.pb
16:15:35.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.901608  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 5099
16:15:35.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.902061  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/master-2/wal/instance
16:15:35.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.903291  5226 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
16:15:35.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.922063  5226 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } has no permanent_uuid. Determining permanent_uuid...
16:15:35.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.948575  5226 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } has no permanent_uuid. Determining permanent_uuid...
16:15:35.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.959508  5226 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } has no permanent_uuid. Determining permanent_uuid...
16:15:35.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.975776  5226 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: Bootstrap starting.
16:15:35.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.982044  5226 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: Neither blocks nor log segments found. Creating new log.
16:15:35.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.983920  5226 log.cc:824] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: Log is configured to *not* fsync() on all Append() calls
16:15:35.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:35.989337  5226 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: No bootstrap required, opened a new log
16:15:36.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.010789  5226 raft_consensus.cc:348] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.011408  5226 raft_consensus.cc:374] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.011669  5226 raft_consensus.cc:729] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b2e6d8f29bb14db0932aa3af176770d3, State: Initialized, Role: FOLLOWER
16:15:36.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.012692  5226 consensus_queue.cc:260] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.016407  5240 sys_catalog.cc:455] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.017266  5240 sys_catalog.cc:458] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.018285  5226 sys_catalog.cc:564] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.039327  4970 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 6
16:15:36.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.041796  5262 catalog_manager.cc:1558] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:15:36.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.042142  5262 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:15:36.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.062951  4970 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: Bootstrap starting.
16:15:36.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.037444  5099 master_runner.cc:186] Error getting master registration for 127.4.186.126:41685: OK, instance_id { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" instance_seqno: 1786464932436616 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:15:36.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.069859  5099 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:15:36.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.070072  4970 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: Neither blocks nor log segments found. Creating new log.
16:15:36.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.072448  4970 log.cc:824] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: Log is configured to *not* fsync() on all Append() calls
16:15:36.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.077418  4970 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: No bootstrap required, opened a new log
16:15:36.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.080318  5158 tablet.cc:2369] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:36.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.107823  4970 raft_consensus.cc:348] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.108697  4970 raft_consensus.cc:374] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.108975  4970 raft_consensus.cc:729] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e29b60e29477430cb71b47c9c0f08317, State: Initialized, Role: FOLLOWER
16:15:36.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.109860  4970 consensus_queue.cc:260] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.112690  5267 sys_catalog.cc:455] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.113379  5267 sys_catalog.cc:458] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.114688  4970 sys_catalog.cc:564] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.145239  4898 tablet.cc:2369] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: Can't schedule compaction. Clean time has not been advanced past its initial value.
16:15:36.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.154837  5285 catalog_manager.cc:1558] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
16:15:36.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:36.155761  5285 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
16:15:36.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.143496  4864 master_runner.cc:186] Error getting master registration for 127.4.186.125:38747: OK, instance_id { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" instance_seqno: 1786464934157795 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
16:15:36.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.171520  4864 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
16:15:36.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.375815  5240 raft_consensus.cc:482] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
16:15:36.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.376333  5240 raft_consensus.cc:504] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.378662  5240 leader_election.cc:288] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers e29b60e29477430cb71b47c9c0f08317 (127.4.186.126:41685), f1612a72ad404244a4b38ec629ff03f7 (127.4.186.125:38747)
16:15:36.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.380155  4933 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b2e6d8f29bb14db0932aa3af176770d3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e29b60e29477430cb71b47c9c0f08317" is_pre_election: true
16:15:36.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.381000  4933 raft_consensus.cc:2454] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b2e6d8f29bb14db0932aa3af176770d3 in term 0.
16:15:36.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.382390  5152 leader_election.cc:302] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [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: b2e6d8f29bb14db0932aa3af176770d3, e29b60e29477430cb71b47c9c0f08317; no voters: 
16:15:36.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.383308  5240 raft_consensus.cc:2781] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Leader pre-election won for term 1
16:15:36.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.383610  5240 raft_consensus.cc:482] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
16:15:36.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.383949  5240 raft_consensus.cc:3037] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.390285  5240 raft_consensus.cc:504] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.392375  5240 leader_election.cc:288] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [CANDIDATE]: Term 1 election: Requested vote from peers e29b60e29477430cb71b47c9c0f08317 (127.4.186.126:41685), f1612a72ad404244a4b38ec629ff03f7 (127.4.186.125:38747)
16:15:36.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.392987  4933 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b2e6d8f29bb14db0932aa3af176770d3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e29b60e29477430cb71b47c9c0f08317"
16:15:36.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.393532  4933 raft_consensus.cc:3037] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.400113  4933 raft_consensus.cc:2454] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b2e6d8f29bb14db0932aa3af176770d3 in term 1.
16:15:36.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.403808  5152 leader_election.cc:302] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [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: b2e6d8f29bb14db0932aa3af176770d3, e29b60e29477430cb71b47c9c0f08317; no voters: 
16:15:36.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.409631  5240 raft_consensus.cc:2781] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 1 FOLLOWER]: Leader election won for term 1
16:15:36.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.418190  5240 raft_consensus.cc:686] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [term 1 LEADER]: Becoming Leader. State: Replica: b2e6d8f29bb14db0932aa3af176770d3, State: Running, Role: LEADER
16:15:36.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.419325  5240 consensus_queue.cc:237] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.431237  5287 sys_catalog.cc:455] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader b2e6d8f29bb14db0932aa3af176770d3. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.432030  5287 sys_catalog.cc:458] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: This master's current role is: LEADER
16:15:36.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.435918  5290 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
16:15:36.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.452868  5290 catalog_manager.cc:1484] Initializing Kudu cluster ID...
16:15:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.498464  4933 raft_consensus.cc:1261] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [term 1 FOLLOWER]: Refusing update from remote peer b2e6d8f29bb14db0932aa3af176770d3: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:36.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.501308  5240 consensus_queue.cc:1035] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:15:36.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.538093  5267 sys_catalog.cc:455] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: SysCatalogTable state changed. Reason: New leader b2e6d8f29bb14db0932aa3af176770d3. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.540025  5092 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } attempt: 7
16:15:36.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.551616  5267 sys_catalog.cc:458] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.564942  5092 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: Bootstrap starting.
16:15:36.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.565838  5267 sys_catalog.cc:455] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.566840  5267 sys_catalog.cc:458] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.572805  5092 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: Neither blocks nor log segments found. Creating new log.
16:15:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.572474  5287 sys_catalog.cc:455] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.573185  5287 sys_catalog.cc:458] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: This master's current role is: LEADER
16:15:36.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.575441  5092 log.cc:824] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: Log is configured to *not* fsync() on all Append() calls
16:15:36.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.588199  5290 catalog_manager.cc:1347] Generated new cluster ID: 93d601c28124410ca8051a372c33e4bf
16:15:36.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.588505  5290 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
16:15:36.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.610035  5092 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: No bootstrap required, opened a new log
16:15:36.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.642417  5092 raft_consensus.cc:348] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.643703  5092 raft_consensus.cc:374] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
16:15:36.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.644225  5092 raft_consensus.cc:729] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f1612a72ad404244a4b38ec629ff03f7, State: Initialized, Role: FOLLOWER
16:15:36.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.645177  5092 consensus_queue.cc:260] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [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: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.650533  5290 catalog_manager.cc:1370] Generated new certificate authority record
16:15:36.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.658422  5290 catalog_manager.cc:1504] Loading token signing keys...
16:15:36.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.659976  5092 sys_catalog.cc:564] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: configured and running, proceeding with master startup.
16:15:36.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.660182  5051 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b2e6d8f29bb14db0932aa3af176770d3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f1612a72ad404244a4b38ec629ff03f7" is_pre_election: true
16:15:36.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.661244  5049 raft_consensus.cc:3037] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 0 FOLLOWER]: Advancing to term 1
16:15:36.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.661705  5050 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "b2e6d8f29bb14db0932aa3af176770d3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f1612a72ad404244a4b38ec629ff03f7"
16:15:36.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.675951  5049 raft_consensus.cc:1261] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 1 FOLLOWER]: Refusing update from remote peer b2e6d8f29bb14db0932aa3af176770d3: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
16:15:36.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.684166  5240 consensus_queue.cc:1035] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
16:15:36.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.686957  5290 catalog_manager.cc:5868] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3: Generated new TSK 0
16:15:36.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.688050  5290 catalog_manager.cc:1514] Initializing in-progress tserver states...
16:15:36.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.699366  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:36.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/logs
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data/info.pb
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:36.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.65:0
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.65
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.65
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:36.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:36.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.730738  5305 sys_catalog.cc:455] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.739037  5305 sys_catalog.cc:458] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.815876  5305 raft_consensus.cc:482] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 1 FOLLOWER]: Starting pre-election (detected failure of leader b2e6d8f29bb14db0932aa3af176770d3)
16:15:36.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.816401  5305 raft_consensus.cc:504] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 1 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } }
16:15:36.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.822258  4933 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "f1612a72ad404244a4b38ec629ff03f7" candidate_term: 2 candidate_status { last_received { term: 1 index: 4 } } ignore_live_leader: false dest_uuid: "e29b60e29477430cb71b47c9c0f08317" is_pre_election: true
16:15:36.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.824355  5313 sys_catalog.cc:455] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.825155  5313 sys_catalog.cc:458] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.826962  5315 sys_catalog.cc:455] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: SysCatalogTable state changed. Reason: New leader b2e6d8f29bb14db0932aa3af176770d3. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:36.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.835059  5315 sys_catalog.cc:458] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [sys.catalog]: This master's current role is: FOLLOWER
16:15:36.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.845785  5305 leader_election.cc:288] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [CANDIDATE]: Term 2 pre-election: Requested pre-vote from peers e29b60e29477430cb71b47c9c0f08317 (127.4.186.126:41685), b2e6d8f29bb14db0932aa3af176770d3 (127.4.186.124:42813)
16:15:36.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.847304  5188 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "f1612a72ad404244a4b38ec629ff03f7" candidate_term: 2 candidate_status { last_received { term: 1 index: 4 } } ignore_live_leader: false dest_uuid: "b2e6d8f29bb14db0932aa3af176770d3" is_pre_election: true
16:15:36.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.849115  5010 leader_election.cc:302] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [CANDIDATE]: Term 2 pre-election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: f1612a72ad404244a4b38ec629ff03f7; no voters: b2e6d8f29bb14db0932aa3af176770d3, e29b60e29477430cb71b47c9c0f08317
16:15:36.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.850385  5305 raft_consensus.cc:2726] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7 [term 1 FOLLOWER]: Leader pre-election lost for term 2. Reason: could not achieve majority
16:15:36.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.866214  5329 catalog_manager.cc:1259] Loaded cluster ID: 93d601c28124410ca8051a372c33e4bf
16:15:36.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.866452  5329 catalog_manager.cc:1552] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: loading cluster ID for follower catalog manager: success
16:15:36.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.873529  5329 catalog_manager.cc:1574] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: acquiring CA information for follower catalog manager: success
16:15:36.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:36.878412  5329 catalog_manager.cc:1602] T 00000000000000000000000000000000 P f1612a72ad404244a4b38ec629ff03f7: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:15:37.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.107342  5240 sys_catalog.cc:455] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "b2e6d8f29bb14db0932aa3af176770d3" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e29b60e29477430cb71b47c9c0f08317" member_type: VOTER last_known_addr { host: "127.4.186.126" port: 41685 } } peers { permanent_uuid: "f1612a72ad404244a4b38ec629ff03f7" member_type: VOTER last_known_addr { host: "127.4.186.125" port: 38747 } } peers { permanent_uuid: "b2e6d8f29bb14db0932aa3af176770d3" member_type: VOTER last_known_addr { host: "127.4.186.124" port: 42813 } } }
16:15:37.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.108093  5240 sys_catalog.cc:458] T 00000000000000000000000000000000 P b2e6d8f29bb14db0932aa3af176770d3 [sys.catalog]: This master's current role is: LEADER
16:15:37.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.161155  5285 catalog_manager.cc:1259] Loaded cluster ID: 93d601c28124410ca8051a372c33e4bf
16:15:37.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.161728  5285 catalog_manager.cc:1552] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: loading cluster ID for follower catalog manager: success
16:15:37.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.173748  5285 catalog_manager.cc:1574] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: acquiring CA information for follower catalog manager: success
16:15:37.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.198087  5285 catalog_manager.cc:1602] T 00000000000000000000000000000000 P e29b60e29477430cb71b47c9c0f08317: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
16:15:37.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.375626  5318 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:37.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.376555  5318 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:37.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.377437  5318 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:37.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.440729  5318 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:37.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.442646  5318 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.186.65
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.502513  5318 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.65:0
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data/info.pb
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.65
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.65
16:15:37.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/logs
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:37.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:37.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:37.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.505524  5318 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:37.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.507462  5318 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:37.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.576200  5342 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:39.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:37.587327  5318 server_base.cc:1034] running on GCE node
16:15:39.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.579205  5346 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:39.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:37.579411  5341 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:39.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.041141  5318 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:39.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.044046  5318 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:39.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.045473  5318 hybrid_clock.cc:648] HybridClock initialized: now 1786464939045449 us; error 46 us; skew 500 ppm
16:15:39.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.046422  5318 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:39.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.053764  5318 webserver.cc:460] Webserver started at http://127.4.186.65:34449/ using document root <none> and password file <none>
16:15:39.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.054664  5318 fs_manager.cc:359] Metadata directory not provided
16:15:39.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.054931  5318 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:39.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.055348  5318 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:39.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.060354  5318 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data/instance:
16:15:39.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "912642b9bcb7420995730195228021a0"
16:15:39.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-39l8"
16:15:39.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.061398  5318 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal/instance:
16:15:39.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "912642b9bcb7420995730195228021a0"
16:15:39.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-39l8"
16:15:39.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.069535  5318 fs_manager.cc:691] Time spent creating directory manager: real 0.008s	user 0.002s	sys 0.007s
16:15:39.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.076143  5358 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:39.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.077327  5318 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
16:15:39.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.077605  5318 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "912642b9bcb7420995730195228021a0"
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:39 on dist-test-slave-39l8"
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.077883  5318 fs_report.cc:383] FS layout report
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data/data
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:39.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:39.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:39.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.141031  5318 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:39.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.142469  5318 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:39.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.142954  5318 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:39.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.146108  5318 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:39.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.150794  5318 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:39.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.151002  5318 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:15:39.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.151298  5318 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:39.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.151449  5318 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:39.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.340351  5318 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.65:38865
16:15:39.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.340459  5541 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.65:38865 every 8 connection(s)
16:15:39.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.343183  5318 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/data/info.pb
16:15:39.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.353601  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 5318
16:15:39.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.354084  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-0/wal/instance
16:15:39.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.370396  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/logs
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data/info.pb
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:39.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.66:0
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.66
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.66
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:39.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:39.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.416421  5547 heartbeater.cc:347] Connected to a master server at 127.4.186.126:41685
16:15:39.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.416949  5547 heartbeater.cc:464] Registering TS with master...
16:15:39.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.418007  5547 heartbeater.cc:511] Master 127.4.186.126:41685 requested a full tablet report, sending...
16:15:39.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.422446  4917 ts_manager.cc:194] Registered new tserver with Master: 912642b9bcb7420995730195228021a0 (127.4.186.65:38865)
16:15:39.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.424693  5544 heartbeater.cc:347] Connected to a master server at 127.4.186.124:42813
16:15:39.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.425017  5544 heartbeater.cc:464] Registering TS with master...
16:15:39.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.426056  5544 heartbeater.cc:511] Master 127.4.186.124:42813 requested a full tablet report, sending...
16:15:39.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.429469  5174 ts_manager.cc:194] Registered new tserver with Master: 912642b9bcb7420995730195228021a0 (127.4.186.65:38865)
16:15:39.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.430275  5542 heartbeater.cc:347] Connected to a master server at 127.4.186.125:38747
16:15:39.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.430559  5542 heartbeater.cc:464] Registering TS with master...
16:15:39.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.431494  5542 heartbeater.cc:511] Master 127.4.186.125:38747 requested a full tablet report, sending...
16:15:39.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.432492  5174 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.186.65:44077
16:15:39.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.434584  5034 ts_manager.cc:194] Registered new tserver with Master: 912642b9bcb7420995730195228021a0 (127.4.186.65:38865)
16:15:39.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.729964  5559 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:39.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.730538  5559 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:39.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.731177  5559 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:39.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.762434  5559 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:39.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.763432  5559 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.186.66
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.797973  5559 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:39.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.66:0
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data/info.pb
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.66
16:15:39.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.66
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/logs
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:39.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.799535  5559 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:39.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.801575  5559 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:39.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.823822  5571 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:40.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:40.438082  5544 heartbeater.cc:503] Master 127.4.186.124:42813 was elected leader, sending a full tablet report...
16:15:41.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.825824  5567 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:41.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:39.826645  5559 server_base.cc:1034] running on GCE node
16:15:41.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:39.826169  5579 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:41.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.009300  5559 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:41.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.011793  5559 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:41.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.013139  5559 hybrid_clock.cc:648] HybridClock initialized: now 1786464941013106 us; error 47 us; skew 500 ppm
16:15:41.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.013917  5559 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:41.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.021024  5559 webserver.cc:460] Webserver started at http://127.4.186.66:32931/ using document root <none> and password file <none>
16:15:41.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.021924  5559 fs_manager.cc:359] Metadata directory not provided
16:15:41.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.022105  5559 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:41.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.022531  5559 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:41.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.028441  5559 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data/instance:
16:15:41.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e640c45d4aa846a48c07f35af98b0bb3"
16:15:41.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-39l8"
16:15:41.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.029476  5559 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal/instance:
16:15:41.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e640c45d4aa846a48c07f35af98b0bb3"
16:15:41.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-39l8"
16:15:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.036552  5559 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.001s	sys 0.007s
16:15:41.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.042011  5590 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.043332  5559 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
16:15:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.043633  5559 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e640c45d4aa846a48c07f35af98b0bb3"
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:41 on dist-test-slave-39l8"
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.043928  5559 fs_report.cc:383] FS layout report
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data/data
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:41.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.090945  5559 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:41.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.092864  5559 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:41.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.093444  5559 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:41.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.096271  5559 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:41.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.100591  5559 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:41.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.100788  5559 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:15:41.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.101014  5559 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:41.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.101150  5559 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:41.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.258852  5559 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.66:43353
16:15:41.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.258963  5770 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.66:43353 every 8 connection(s)
16:15:41.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.261181  5559 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/data/info.pb
16:15:41.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.272770  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 5559
16:15:41.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.273653  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-1/wal/instance
16:15:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.300494  4841 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/logs
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data/info.pb
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.67:0
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.67
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.67
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:41.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:41.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:41.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
16:15:41.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.304291  5772 heartbeater.cc:347] Connected to a master server at 127.4.186.125:38747
16:15:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.305061  5772 heartbeater.cc:464] Registering TS with master...
16:15:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.306416  5772 heartbeater.cc:511] Master 127.4.186.125:38747 requested a full tablet report, sending...
16:15:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.309046  5773 heartbeater.cc:347] Connected to a master server at 127.4.186.124:42813
16:15:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.309406  5773 heartbeater.cc:464] Registering TS with master...
16:15:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.309820  5034 ts_manager.cc:194] Registered new tserver with Master: e640c45d4aa846a48c07f35af98b0bb3 (127.4.186.66:43353)
16:15:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.310276  5773 heartbeater.cc:511] Master 127.4.186.124:42813 requested a full tablet report, sending...
16:15:41.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.312428  5174 ts_manager.cc:194] Registered new tserver with Master: e640c45d4aa846a48c07f35af98b0bb3 (127.4.186.66:43353)
16:15:41.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.314417  5174 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.186.66:36143
16:15:41.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.315599  5777 heartbeater.cc:347] Connected to a master server at 127.4.186.126:41685
16:15:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.315954  5777 heartbeater.cc:464] Registering TS with master...
16:15:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.316767  5777 heartbeater.cc:511] Master 127.4.186.126:41685 requested a full tablet report, sending...
16:15:41.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.320359  4917 ts_manager.cc:194] Registered new tserver with Master: e640c45d4aa846a48c07f35af98b0bb3 (127.4.186.66:43353)
16:15:41.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.623397  5783 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
16:15:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.623924  5783 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
16:15:41.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.624485  5783 flags.cc:425] Enabled unsafe flag: --never_fsync=true
16:15:41.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.653919  5783 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
16:15:41.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.654786  5783 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.186.67
16:15:41.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.686523  5783 tablet_server_runner.cc:78] Tablet server non-default flags:
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.186.84:44785
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.186.67:0
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data/info.pb
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.186.67
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.186.126:41685,127.4.186.125:38747,127.4.186.124:42813
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.186.67
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/logs
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
16:15:41.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
16:15:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 15:14:16 UTC on ccycloud.quasar-uwbvwl.root.comops.site
16:15:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580677
16:15:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
16:15:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.688007  5783 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
16:15:41.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.689602  5783 file_cache.cc:493] Constructed file cache file cache with capacity 419430
16:15:41.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.706784  5793 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:42.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.318668  5773 heartbeater.cc:503] Master 127.4.186.124:42813 was elected leader, sending a full tablet report...
16:15:42.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.707049  5794 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:42.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:41.709931  5783 server_base.cc:1034] running on GCE node
16:15:42.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 16:15:41.710304  5798 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
16:15:42.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.856801  5783 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
16:15:42.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.859472  5783 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
16:15:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.860888  5783 hybrid_clock.cc:648] HybridClock initialized: now 1786464942860844 us; error 66 us; skew 500 ppm
16:15:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.861604  5783 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
16:15:42.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.871642  5783 webserver.cc:460] Webserver started at http://127.4.186.67:40717/ using document root <none> and password file <none>
16:15:42.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.872507  5783 fs_manager.cc:359] Metadata directory not provided
16:15:42.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.872710  5783 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
16:15:42.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.873093  5783 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
16:15:42.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.877983  5783 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data/instance:
16:15:42.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fbfeb0c4af994ece95ed7cfd4b749783"
16:15:42.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:42 on dist-test-slave-39l8"
16:15:42.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.879127  5783 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal/instance:
16:15:42.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fbfeb0c4af994ece95ed7cfd4b749783"
16:15:42.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:42 on dist-test-slave-39l8"
16:15:42.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.886607  5783 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.002s	sys 0.005s
16:15:42.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.891835  5812 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.892916  5783 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.893203  5783 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data,/tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fbfeb0c4af994ece95ed7cfd4b749783"
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 16:15:42 on dist-test-slave-39l8"
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.893491  5783 fs_report.cc:383] FS layout report
16:15:42.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data/data
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
16:15:42.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
16:15:42.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.927969  5783 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
16:15:42.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.929351  5783 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
16:15:42.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.929765  5783 kserver.cc:163] Server-wide thread pool size limit: 3276
16:15:42.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.932706  5783 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
16:15:42.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.937361  5783 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
16:15:42.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.937556  5783 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
16:15:42.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.937776  5783 ts_tablet_manager.cc:610] Registered 0 tablets
16:15:42.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:42.937928  5783 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
16:15:43.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.087996  5783 rpc_server.cc:307] RPC server started. Bound to: 127.4.186.67:46289
16:15:43.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.088038  5992 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.4.186.67:46289 every 8 connection(s)
16:15:43.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.090337  5783 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/data/info.pb
16:15:43.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.100294  4841 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu as pid 5783
16:15:43.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.100869  4841 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskEGVkvP/test-tmp/mini-kudu-cluster4365147913383559947/ts-2/wal/instance
16:15:43.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.143043  5993 heartbeater.cc:347] Connected to a master server at 127.4.186.125:38747
16:15:43.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.143566  5993 heartbeater.cc:464] Registering TS with master...
16:15:43.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.144244  5994 heartbeater.cc:347] Connected to a master server at 127.4.186.124:42813
16:15:43.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.144559  5994 heartbeater.cc:464] Registering TS with master...
16:15:43.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.144779  5993 heartbeater.cc:511] Master 127.4.186.125:38747 requested a full tablet report, sending...
16:15:43.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.145557  5994 heartbeater.cc:511] Master 127.4.186.124:42813 requested a full tablet report, sending...
16:15:43.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.147405  5995 heartbeater.cc:347] Connected to a master server at 127.4.186.126:41685
16:15:43.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.147782  5995 heartbeater.cc:464] Registering TS with master...
16:15:43.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.147691  5174 ts_manager.cc:194] Registered new tserver with Master: fbfeb0c4af994ece95ed7cfd4b749783 (127.4.186.67:46289)
16:15:43.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.148290  5034 ts_manager.cc:194] Registered new tserver with Master: fbfeb0c4af994ece95ed7cfd4b749783 (127.4.186.67:46289)
16:15:43.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.148551  5995 heartbeater.cc:511] Master 127.4.186.126:41685 requested a full tablet report, sending...
16:15:43.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.150007  5174 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.4.186.67:37447
16:15:43.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.151142  4917 ts_manager.cc:194] Registered new tserver with Master: fbfeb0c4af994ece95ed7cfd4b749783 (127.4.186.67:46289)
16:15:43.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:43.170816  4841 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
16:15:43.186 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
16:15:43.187 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

16:15:43.199 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.186.126"
      port: 41685
    }
    bound_http_address {
      host: "127.4.186.126"
      port: 34593
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.186.125"
      port: 38747
    }
    bound_http_address {
      host: "127.4.186.125"
      port: 46565
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.186.124"
      port: 42813
    }
    bound_http_address {
      host: "127.4.186.124"
      port: 42487
    }
  }
}

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

16:15:43.208 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.186.65"
      port: 38865
    }
    bound_http_address {
      host: "127.4.186.65"
      port: 34449
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.186.66"
      port: 43353
    }
    bound_http_address {
      host: "127.4.186.66"
      port: 32931
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.186.67"
      port: 46289
    }
    bound_http_address {
      host: "127.4.186.67"
      port: 40717
    }
  }
}

16:15:43.208 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
16:15:43.400 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
16:15:43.565 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.4.186.124:42813(127.4.186.124:42813)] connecting to peer
16:15:43.623 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.4.186.125:38747(127.4.186.125:38747)] connecting to peer
16:15:43.625 [DEBUG - Time-limited test] (Connection.java:748) [peer master-127.4.186.126:41685(127.4.186.126:41685)] connecting to peer
16:15:43.667 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.4.186.125:38747(127.4.186.125:38747)] Successfully connected to peer
16:15:43.672 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.4.186.124:42813(127.4.186.124:42813)] Successfully connected to peer
16:15:43.733 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.4.186.126:41685(127.4.186.126:41685)] Successfully connected to peer
16:15:43.754 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.186.124
16:15:43.754 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.186.125
16:15:43.849 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.186.126
16:15:43.974 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xaaf01ffd, L:/127.0.0.1:53046 - R:/127.4.186.124:42813] using SASL/PLAIN
16:15:43.974 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd04df0e7, L:/127.0.0.1:38704 - R:/127.4.186.125:38747] using SASL/PLAIN
16:15:43.979 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x5bfd7632, L:/127.0.0.1:37452 - R:/127.4.186.126:41685] using SASL/PLAIN
16:15:44.019 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
16:15:44.021 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=505), Traces: [0ms] refreshing cache from master, [33ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.186.124:42813, [102ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.186.125:38747, [104ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.186.126:41685, [470ms] Sub RPC ConnectToMaster: received response from server master-127.4.186.125:38747: OK, [470ms] Sub RPC ConnectToMaster: received response from server master-127.4.186.124:42813: OK, deferred=null) after lookup
16:15:44.036 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.4.186.124:42813(127.4.186.124:42813)] disconnecting while in state READY
16:15:44.041 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.4.186.124:42813(127.4.186.124:42813)] handling channelInactive
16:15:44.042 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.4.186.124:42813(127.4.186.124:42813)] cleaning up while in state READY due to: connection closed
16:15:44.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:44.154335  5994 heartbeater.cc:503] Master 127.4.186.124:42813 was elected leader, sending a full tablet report...
16:15:44.793 [DEBUG - Time-limited test] (Connection.java:748) [peer fake-uuid(127.4.186.124:42813)] connecting to peer
16:15:44.795 [DEBUG - kudu-nio-1] (Connection.java:757) [peer fake-uuid(127.4.186.124:42813)] Successfully connected to peer
16:15:44.852 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x2c0477be, L:/127.0.0.1:53062 - R:/127.4.186.124:42813] using TOKEN/null
16:15:44.858 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.4.186.126:41685(127.4.186.126:41685)] disconnecting while in state READY
16:15:44.859 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.4.186.126:41685(127.4.186.126:41685)] handling channelInactive
16:15:44.860 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.4.186.126:41685(127.4.186.126:41685)] cleaning up while in state READY due to: connection closed
16:15:44.860 [DEBUG - Time-limited test] (Connection.java:575) [peer fake-uuid(127.4.186.124:42813)] disconnecting while in state READY
16:15:44.861 [DEBUG - kudu-nio-1] (Connection.java:239) [peer fake-uuid(127.4.186.124:42813)] handling channelInactive
16:15:44.861 [DEBUG - kudu-nio-1] (Connection.java:709) [peer fake-uuid(127.4.186.124:42813)] cleaning up while in state READY due to: connection closed
16:15:45.111 [DEBUG - Time-limited test] (Connection.java:575) [peer master-127.4.186.125:38747(127.4.186.125:38747)] disconnecting while in state READY
16:15:45.113 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.4.186.125:38747(127.4.186.125:38747)] handling channelInactive
16:15:45.113 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.4.186.125:38747(127.4.186.125:38747)] cleaning up while in state READY due to: connection closed
16:15:45.364 [DEBUG - main] (Connection.java:575) [peer master-127.4.186.126:41685(127.4.186.126:41685)] disconnecting while in state TERMINATED
16:15:45.366 [DEBUG - main] (Connection.java:575) [peer fake-uuid(127.4.186.124:42813)] disconnecting while in state TERMINATED
16:15:45.366 [DEBUG - main] (Connection.java:575) [peer master-127.4.186.125:38747(127.4.186.125:38747)] disconnecting while in state TERMINATED
16:15:45.368 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
16:15:45.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.369908  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 5318
16:15:45.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.402879  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 5559
16:15:45.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.443555  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 5783
16:15:45.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.479776  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 4864
16:15:45.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.512567  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 4972
16:15:45.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 16:15:45.543460  4841 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskEGVkvP/build/tsan/bin/kudu with pid 5099
16:15:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T16:15:46Z chronyd exiting

Time: 18.271

OK (1 test)

