JUnit version 4.13.2
.06:04:49.427 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1786514689413
06:04:49.466 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
06:04:49.522 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
06:04:49.532 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskCDPYZu/test-tmp
06:04:49.566 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
06:04:49.570 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskCDPYZu/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
06:04:49.803 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

06:04:49.997 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:04:49.999 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:04:50.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.001457 17048 mini_oidc.cc:150] Starting JWKS server
06:04:50.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.003976 17048 webserver.cc:533] Webserver started at http://127.0.0.1:34615/ using document root <none> and password file <none>
06:04:50.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.004374 17048 mini_oidc.cc:186] Starting OIDC Discovery server
06:04:50.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.004781 17048 webserver.cc:533] Webserver started at http://127.0.0.1:39121/ using document root <none> and password file <none>
06:04:50.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:04:50Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
06:04:50.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:04:50Z Disabled control of system clock
06:04:50.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.026216 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal
06:04:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data
06:04:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:50.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:50.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:50.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/logs
06:04:50.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data/info.pb
06:04:50.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:50.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:50.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:50.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:50.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.62:44597
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.62
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json with env {}
06:04:50.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.163280 17061 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:50.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.163600 17061 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:50.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.163658 17061 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:50.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.167834 17061 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
06:04:50.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.167922 17061 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:50.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.167945 17061 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
06:04:50.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.167964 17061 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
06:04:50.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.167984 17061 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
06:04:50.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.168001 17061 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34615/jwks.json
06:04:50.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.174180 17061 master_runner.cc:387] Master server non-default flags:
06:04:50.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.62:44597
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data/info.pb
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.62
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17061
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/logs
06:04:50.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:50.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:50.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.175915 17061 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:50.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.177522 17061 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:50.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.186741 17071 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
06:04:50.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.186741 17068 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
06:04:50.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.186795 17069 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
06:04:50.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.187318 17061 server_base.cc:1061] running on GCE node
06:04:50.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.188133 17061 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.189913 17061 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.191185 17061 hybrid_clock.cc:648] HybridClock initialized: now 1786514690191161 us; error 47 us; skew 500 ppm
06:04:50.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.194054 17061 webserver.cc:533] Webserver started at http://127.16.166.62:41109/ using document root <none> and password file <none>
06:04:50.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.195014 17061 fs_manager.cc:362] Metadata directory not provided
06:04:50.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.195163 17061 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:50.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.195500 17061 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:50.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.197654 17061 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data/instance:
06:04:50.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3777259a662241b1bc8f59d9a4ce85e1"
06:04:50.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.198349 17061 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal/instance:
06:04:50.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3777259a662241b1bc8f59d9a4ce85e1"
06:04:50.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.203223 17061 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.000s
06:04:50.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.206876 17080 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:50.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.208729 17061 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
06:04:50.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.208935 17061 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal
06:04:50.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3777259a662241b1bc8f59d9a4ce85e1"
06:04:50.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.209085 17061 fs_report.cc:389] FS layout report
06:04:50.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:50.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal
06:04:50.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal
06:04:50.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data/data
06:04:50.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:50.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:50.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:50.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:50.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:50.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:50.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:50.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:50.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:50.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:50.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:50.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.231163 17061 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:50.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.232507 17061 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:50.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.232836 17061 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:50.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.243530 17061 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.62:44597
06:04:50.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.243500 17142 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.62:44597 every 8 connection(s)
06:04:50.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.245165 17061 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/data/info.pb
06:04:50.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.250260 17143 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:50.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.251770 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17061
06:04:50.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.251967 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-0/wal/instance
06:04:50.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.253806 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal
06:04:50.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data
06:04:50.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/logs
06:04:50.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data/info.pb
06:04:50.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:50.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:50.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:50.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:50.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.61:34265
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.61
06:04:50.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json with env {}
06:04:50.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.254452 17143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.274952 17143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.276265 17083 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.16.166.61:34265: connect: Connection refused (error 111)
06:04:50.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.277738 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.61:34265: Network error: Client connection negotiation failed: client connection to 127.16.166.61:34265: connect: Connection refused (error 111)
06:04:50.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.327073 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } attempt: 1
06:04:50.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.329231 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.61:34265: Network error: Client connection negotiation failed: client connection to 127.16.166.61:34265: connect: Connection refused (error 111)
06:04:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.397505 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } attempt: 2
06:04:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.398085 17145 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.398341 17145 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.398393 17145 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:50.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.399724 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.61:34265: Network error: Client connection negotiation failed: client connection to 127.16.166.61:34265: connect: Connection refused (error 111)
06:04:50.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404369 17145 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
06:04:50.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404491 17145 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:50.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404524 17145 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
06:04:50.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404551 17145 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
06:04:50.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404579 17145 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
06:04:50.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.404600 17145 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34615/jwks.json
06:04:50.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.411012 17145 master_runner.cc:387] Master server non-default flags:
06:04:50.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data
06:04:50.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal
06:04:50.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.61:34265
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json
06:04:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data/info.pb
06:04:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.61
06:04:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:50.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17145
06:04:50.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:50.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/logs
06:04:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:50.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.412524 17145 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:50.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.414323 17145 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:50.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.424454 17154 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
06:04:50.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.424378 17153 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
06:04:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.425338 17157 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
06:04:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.426374 17145 server_base.cc:1061] running on GCE node
06:04:50.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.427218 17145 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:50.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.428679 17145 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:50.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.429947 17145 hybrid_clock.cc:648] HybridClock initialized: now 1786514690429793 us; error 191 us; skew 500 ppm
06:04:50.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.432823 17145 webserver.cc:533] Webserver started at http://127.16.166.61:37649/ using document root <none> and password file <none>
06:04:50.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.433881 17145 fs_manager.cc:362] Metadata directory not provided
06:04:50.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.433996 17145 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:50.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.434293 17145 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.436749 17145 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data/instance:
06:04:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd125f23a5fa4cf49304276eb0ef7460"
06:04:50.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.437541 17145 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal/instance:
06:04:50.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd125f23a5fa4cf49304276eb0ef7460"
06:04:50.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.443328 17145 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.002s	sys 0.004s
06:04:50.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.447325 17163 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:50.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.449553 17145 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.000s	sys 0.003s
06:04:50.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.449906 17145 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal
06:04:50.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd125f23a5fa4cf49304276eb0ef7460"
06:04:50.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.450067 17145 fs_report.cc:389] FS layout report
06:04:50.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:50.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal
06:04:50.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal
06:04:50.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data/data
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:50.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:50.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:50.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:50.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:50.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:50.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.489296 17145 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:50.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.490497 17145 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:50.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.490778 17145 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:50.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.490947 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } attempt: 3
06:04:50.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.493466 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.61:34265: Network error: Client connection negotiation failed: client connection to 127.16.166.61:34265: connect: Connection refused (error 111)
06:04:50.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.502971 17145 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.61:34265
06:04:50.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.502983 17223 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.61:34265 every 8 connection(s)
06:04:50.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.504475 17145 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/data/info.pb
06:04:50.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.505056 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17145
06:04:50.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.505201 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-1/wal/instance
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.505954 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:50.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/logs
06:04:50.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data/info.pb
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.60:34011
06:04:50.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.60
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json with env {}
06:04:50.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.508563 17224 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:50.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.513309 17224 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.527756 17224 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.536008 17224 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.537108 17164 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.538578 17224 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.60:34011: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.587918 17224 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } attempt: 1
06:04:50.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.590530 17224 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.60:34011: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.637107 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } attempt: 4
06:04:50.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.643244 17143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.645483 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.60:34011: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.653817 17227 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:50.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.654140 17227 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:50.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.654193 17227 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:50.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.658780 17224 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } attempt: 2
06:04:50.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659322 17227 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
06:04:50.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659454 17227 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:50.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659478 17227 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
06:04:50.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659497 17227 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
06:04:50.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659518 17227 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
06:04:50.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.659533 17227 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34615/jwks.json
06:04:50.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.660916 17224 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.60:34011: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.664719 17227 master_runner.cc:387] Master server non-default flags:
06:04:50.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.60:34011
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:04:50.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34615/jwks.json
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data/info.pb
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.60
06:04:50.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:50.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17227
06:04:50.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:50.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:50.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/logs
06:04:50.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:50.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:50.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:50.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.666453 17227 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:50.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.668681 17227 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:50.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.677785 17239 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
06:04:50.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.677785 17237 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
06:04:50.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.677785 17236 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
06:04:50.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.678843 17227 server_base.cc:1061] running on GCE node
06:04:50.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.679886 17227 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:50.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.681278 17227 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:50.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.682466 17227 hybrid_clock.cc:648] HybridClock initialized: now 1786514690682345 us; error 160 us; skew 500 ppm
06:04:50.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.685003 17227 webserver.cc:533] Webserver started at http://127.16.166.60:43799/ using document root <none> and password file <none>
06:04:50.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.685854 17227 fs_manager.cc:362] Metadata directory not provided
06:04:50.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.685961 17227 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:50.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.686242 17227 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:50.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.688280 17227 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data/instance:
06:04:50.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0a5f6f379e2b47a4994258cdbe84663d"
06:04:50.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.688961 17227 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal/instance:
06:04:50.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0a5f6f379e2b47a4994258cdbe84663d"
06:04:50.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.693849 17227 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.005s	sys 0.000s
06:04:50.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.697621 17246 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:50.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.699126 17227 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
06:04:50.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.699333 17227 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal
06:04:50.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0a5f6f379e2b47a4994258cdbe84663d"
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:50 on dist-test-slave-btw8"
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.699496 17227 fs_report.cc:389] FS layout report
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data/data
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:50.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.704805 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } attempt: 1
06:04:50.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.707515 17143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.16.166.60:34011: Network error: Client connection negotiation failed: client connection to 127.16.166.60:34011: connect: Connection refused (error 111)
06:04:50.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.714092 17227 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:50.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.715140 17227 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:50.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.715487 17227 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:50.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.727023 17227 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.60:34011
06:04:50.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.727029 17305 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.60:34011 every 8 connection(s)
06:04:50.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.728881 17227 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/data/info.pb
06:04:50.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.734051 17306 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:50.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.736770 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17227
06:04:50.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.736876 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/master-2/wal/instance
06:04:50.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.738505 17306 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.751192 17306 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.752755 17224 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } attempt: 3
06:04:50.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.757795 17306 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } has no permanent_uuid. Determining permanent_uuid...
06:04:50.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.764583 17224 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: Bootstrap starting.
06:04:50.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.767922 17224 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: Neither blocks nor log segments found. Creating new log.
06:04:50.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.770495 17224 log.cc:826] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: Log is configured to *not* fsync() on all Append() calls
06:04:50.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.772019 17306 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: Bootstrap starting.
06:04:50.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.773274 17224 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: No bootstrap required, opened a new log
06:04:50.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.774762 17143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } attempt: 2
06:04:50.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.774983 17306 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: Neither blocks nor log segments found. Creating new log.
06:04:50.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.776530 17306 log.cc:826] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: Log is configured to *not* fsync() on all Append() calls
06:04:50.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.777295 17224 raft_consensus.cc:359] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.777529 17224 raft_consensus.cc:385] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:50.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.777618 17224 raft_consensus.cc:740] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bd125f23a5fa4cf49304276eb0ef7460, State: Initialized, Role: FOLLOWER
06:04:50.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.778303 17224 consensus_queue.cc:260] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.778955 17306 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: No bootstrap required, opened a new log
06:04:50.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.781286 17319 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.781999 17319 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.782011 17224 sys_catalog.cc:565] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: configured and running, proceeding with master startup.
06:04:50.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.782790 17306 raft_consensus.cc:359] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.783325 17306 raft_consensus.cc:385] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:50.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.783676 17306 raft_consensus.cc:740] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0a5f6f379e2b47a4994258cdbe84663d, State: Initialized, Role: FOLLOWER
06:04:50.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.784071 17143 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: Bootstrap starting.
06:04:50.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.784521 17306 consensus_queue.cc:260] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.786000 17306 sys_catalog.cc:565] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: configured and running, proceeding with master startup.
06:04:50.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.788287 17143 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: Neither blocks nor log segments found. Creating new log.
06:04:50.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.789294 17143 log.cc:826] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: Log is configured to *not* fsync() on all Append() calls
06:04:50.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.789113 17145 master_runner.cc:187] Error getting master registration for 127.16.166.62:44597: OK, instance_id { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" instance_seqno: 1786514690240789 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
06:04:50.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.791275 17339 catalog_manager.cc:1614] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:04:50.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.791518 17145 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
06:04:50.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.791574 17339 catalog_manager.cc:884] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:04:50.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.794198 17325 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.794770 17325 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.796056 17143 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: No bootstrap required, opened a new log
06:04:50.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.797350 17319 raft_consensus.cc:493] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.797515 17319 raft_consensus.cc:515] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.798856 17319 leader_election.cc:290] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3777259a662241b1bc8f59d9a4ce85e1 (127.16.166.62:44597), 0a5f6f379e2b47a4994258cdbe84663d (127.16.166.60:34011)
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.799201 17348 catalog_manager.cc:1614] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.799288 17348 catalog_manager.cc:884] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.796764 17227 master_runner.cc:187] Error getting master registration for 127.16.166.62:44597: OK, instance_id { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" instance_seqno: 1786514690240789 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.799571 17227 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.799750 17278 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd125f23a5fa4cf49304276eb0ef7460" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0a5f6f379e2b47a4994258cdbe84663d" is_pre_election: true
06:04:50.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.799990 17278 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate bd125f23a5fa4cf49304276eb0ef7460 in term 0.
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.800330 17143 raft_consensus.cc:359] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.800537 17143 raft_consensus.cc:385] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.800523 17164 leader_election.cc:304] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [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: 0a5f6f379e2b47a4994258cdbe84663d, bd125f23a5fa4cf49304276eb0ef7460; no voters: 
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.800607 17143 raft_consensus.cc:740] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3777259a662241b1bc8f59d9a4ce85e1, State: Initialized, Role: FOLLOWER
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.800925 17319 raft_consensus.cc:2804] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Leader pre-election won for term 1
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.801014 17319 raft_consensus.cc:493] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.801054 17319 raft_consensus.cc:3060] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 0 FOLLOWER]: Advancing to term 1
06:04:50.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.801196 17143 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.801870 17350 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.802296 17319 raft_consensus.cc:515] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.802362 17350 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.802783 17143 sys_catalog.cc:565] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: configured and running, proceeding with master startup.
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.802843 17110 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd125f23a5fa4cf49304276eb0ef7460" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3777259a662241b1bc8f59d9a4ce85e1" is_pre_election: true
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.803257 17110 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate bd125f23a5fa4cf49304276eb0ef7460 in term 0.
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.803510 17109 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd125f23a5fa4cf49304276eb0ef7460" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3777259a662241b1bc8f59d9a4ce85e1"
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.803632 17109 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 0 FOLLOWER]: Advancing to term 1
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.805086 17109 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bd125f23a5fa4cf49304276eb0ef7460 in term 1.
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.807752 17167 leader_election.cc:304] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [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: 3777259a662241b1bc8f59d9a4ce85e1, bd125f23a5fa4cf49304276eb0ef7460; no voters: 
06:04:50.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.808257 17363 raft_consensus.cc:2804] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 1 FOLLOWER]: Leader election won for term 1
06:04:50.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.808473 17363 raft_consensus.cc:697] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [term 1 LEADER]: Becoming Leader. State: Replica: bd125f23a5fa4cf49304276eb0ef7460, State: Running, Role: LEADER
06:04:50.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.808857 17363 consensus_queue.cc:237] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [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: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } }
06:04:50.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.812093 17363 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd125f23a5fa4cf49304276eb0ef7460. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.812278 17363 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: This master's current role is: LEADER
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.813820 17319 leader_election.cc:290] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [CANDIDATE]: Term 1 election: Requested vote from peers 3777259a662241b1bc8f59d9a4ce85e1 (127.16.166.62:44597), 0a5f6f379e2b47a4994258cdbe84663d (127.16.166.60:34011)
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.814132 17278 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bd125f23a5fa4cf49304276eb0ef7460" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0a5f6f379e2b47a4994258cdbe84663d"
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.814301 17278 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 0 FOLLOWER]: Advancing to term 1
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.815084 17362 catalog_manager.cc:1614] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:50.815168 17362 catalog_manager.cc:884] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:04:50.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.815698 17278 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bd125f23a5fa4cf49304276eb0ef7460 in term 1.
06:04:50.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.819794 17367 catalog_manager.cc:1531] Loading table and tablet metadata into memory...
06:04:50.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.821254 17367 catalog_manager.cc:1540] Initializing Kudu cluster ID...
06:04:50.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.832602 17278 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [term 1 FOLLOWER]: Refusing update from remote peer bd125f23a5fa4cf49304276eb0ef7460: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:04:50.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.833489 17319 consensus_queue.cc:1048] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [LEADER]: Connected to new peer: Peer: permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:04:50.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.838972 17325 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd125f23a5fa4cf49304276eb0ef7460. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.839156 17325 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.849503 17109 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [term 1 FOLLOWER]: Refusing update from remote peer bd125f23a5fa4cf49304276eb0ef7460: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:04:50.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.851058 17319 consensus_queue.cc:1048] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [LEADER]: Connected to new peer: Peer: permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:04:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.854770 17319 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.854970 17319 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: This master's current role is: LEADER
06:04:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.856979 17325 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.857197 17325 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.857255 17350 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bd125f23a5fa4cf49304276eb0ef7460. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.857379 17350 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.859738 17368 mvcc.cc:204] Tried to move back new op lower bound from 7317564173640708096 to 7317564173560827904. Current Snapshot: MvccSnapshot[applied={T|T < 7317564173640708096}]
06:04:50.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.860713 17369 mvcc.cc:204] Tried to move back new op lower bound from 7317564173640708096 to 7317564173560827904. Current Snapshot: MvccSnapshot[applied={T|T < 7317564173640708096}]
06:04:50.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.867376 17367 catalog_manager.cc:1384] Generated new cluster ID: b9df872f22ae4ebcacbb2f5bdab1fa31
06:04:50.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.867488 17367 catalog_manager.cc:1551] Initializing Kudu internal certificate authority...
06:04:50.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.873648 17363 sys_catalog.cc:455] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.873821 17363 sys_catalog.cc:458] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460 [sys.catalog]: This master's current role is: LEADER
06:04:50.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.876572 17350 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bd125f23a5fa4cf49304276eb0ef7460" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3777259a662241b1bc8f59d9a4ce85e1" member_type: VOTER last_known_addr { host: "127.16.166.62" port: 44597 } } peers { permanent_uuid: "bd125f23a5fa4cf49304276eb0ef7460" member_type: VOTER last_known_addr { host: "127.16.166.61" port: 34265 } } peers { permanent_uuid: "0a5f6f379e2b47a4994258cdbe84663d" member_type: VOTER last_known_addr { host: "127.16.166.60" port: 34011 } } }
06:04:50.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.876763 17350 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1 [sys.catalog]: This master's current role is: FOLLOWER
06:04:50.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.877956 17373 mvcc.cc:204] Tried to move back new op lower bound from 7317564173640708096 to 7317564173560827904. Current Snapshot: MvccSnapshot[applied={T|T < 7317564173640708096}]
06:04:50.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.893009 17367 catalog_manager.cc:1407] Generated new certificate authority record
06:04:50.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.895172 17367 catalog_manager.cc:1560] Loading token signing keys...
06:04:50.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.935341 17367 catalog_manager.cc:6112] T 00000000000000000000000000000000 P bd125f23a5fa4cf49304276eb0ef7460: Generated new TSK 0
06:04:50.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.937237 17367 catalog_manager.cc:1570] Initializing in-progress tserver states...
06:04:50.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:50.950359 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/logs
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data/info.pb
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.1:0
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.1
06:04:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.1
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:04:51.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.157533 17379 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:51.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.157830 17379 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:51.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.157884 17379 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:51.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.162250 17379 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:51.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.162405 17379 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.166.1
06:04:51.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.167586 17379 tablet_server_runner.cc:78] Tablet server non-default flags:
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data
06:04:51.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.1:0
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data/info.pb
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.1
06:04:51.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17379
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.1
06:04:51.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/logs
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:51.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:51.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:51.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.169061 17379 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:51.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.170935 17379 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:51.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.180452 17386 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
06:04:51.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.180459 17385 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
06:04:51.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.180418 17388 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
06:04:51.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.182108 17379 server_base.cc:1061] running on GCE node
06:04:51.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.182682 17379 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:51.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.183471 17379 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:51.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.184724 17379 hybrid_clock.cc:648] HybridClock initialized: now 1786514691184697 us; error 52 us; skew 500 ppm
06:04:51.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.187583 17379 webserver.cc:533] Webserver started at http://127.16.166.1:46559/ using document root <none> and password file <none>
06:04:51.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.188431 17379 fs_manager.cc:362] Metadata directory not provided
06:04:51.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.188544 17379 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:51.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.188851 17379 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:51.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.190953 17379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data/instance:
06:04:51.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d489b09dbb544bebc1e1349110e7854"
06:04:51.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.191980 17379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal/instance:
06:04:51.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d489b09dbb544bebc1e1349110e7854"
06:04:51.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.197808 17379 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.005s	sys 0.000s
06:04:51.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.201750 17394 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.203680 17379 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.203924 17379 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7d489b09dbb544bebc1e1349110e7854"
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.204082 17379 fs_report.cc:389] FS layout report
06:04:51.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data/data
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:51.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:51.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:51.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.248425 17379 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:51.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.249344 17379 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:51.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.249558 17379 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:51.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.250511 17379 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
06:04:51.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.252120 17379 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:04:51.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.252203 17379 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:04:51.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.252269 17379 ts_tablet_manager.cc:616] Registered 0 tablets
06:04:51.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.252290 17379 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:04:51.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.266882 17379 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.1:41933
06:04:51.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.266925 17520 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.1:41933 every 8 connection(s)
06:04:51.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.268594 17379 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/data/info.pb
06:04:51.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.269325 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17379
06:04:51.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.269448 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-0/wal/instance
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.273511 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:51.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/logs
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data/info.pb
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.2:0
06:04:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.2
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.2
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:04:51.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.283890 17523 heartbeater.cc:344] Connected to a master server at 127.16.166.61:34265
06:04:51.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.283924 17521 heartbeater.cc:344] Connected to a master server at 127.16.166.60:34011
06:04:51.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.284355 17521 heartbeater.cc:461] Registering TS with master...
06:04:51.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.284387 17523 heartbeater.cc:461] Registering TS with master...
06:04:51.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.285235 17523 heartbeater.cc:507] Master 127.16.166.61:34265 requested a full tablet report, sending...
06:04:51.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.285235 17521 heartbeater.cc:507] Master 127.16.166.60:34011 requested a full tablet report, sending...
06:04:51.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.286057 17522 heartbeater.cc:344] Connected to a master server at 127.16.166.62:44597
06:04:51.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.286166 17522 heartbeater.cc:461] Registering TS with master...
06:04:51.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.286429 17522 heartbeater.cc:507] Master 127.16.166.62:44597 requested a full tablet report, sending...
06:04:51.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.287932 17097 ts_manager.cc:194] Registered new tserver with Master: 7d489b09dbb544bebc1e1349110e7854 (127.16.166.1:41933)
06:04:51.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.288403 17266 ts_manager.cc:194] Registered new tserver with Master: 7d489b09dbb544bebc1e1349110e7854 (127.16.166.1:41933)
06:04:51.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.289502 17182 ts_manager.cc:194] Registered new tserver with Master: 7d489b09dbb544bebc1e1349110e7854 (127.16.166.1:41933)
06:04:51.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.291762 17182 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.166.1:58051
06:04:51.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.421819 17531 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:51.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.422124 17531 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:51.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.422178 17531 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:51.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.426313 17531 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:51.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.426455 17531 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.166.2
06:04:51.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.432260 17531 tablet_server_runner.cc:78] Tablet server non-default flags:
06:04:51.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.2:0
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data/info.pb
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.2
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:51.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17531
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.2
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/logs
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:51.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.433818 17531 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:51.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.435168 17531 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:51.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.443580 17539 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
06:04:51.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.443581 17537 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
06:04:51.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.443581 17536 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
06:04:51.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.443889 17531 server_base.cc:1061] running on GCE node
06:04:51.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.444813 17531 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:51.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.445574 17531 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:51.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.446820 17531 hybrid_clock.cc:648] HybridClock initialized: now 1786514691446796 us; error 40 us; skew 500 ppm
06:04:51.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.449393 17531 webserver.cc:533] Webserver started at http://127.16.166.2:38457/ using document root <none> and password file <none>
06:04:51.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.450016 17531 fs_manager.cc:362] Metadata directory not provided
06:04:51.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.450076 17531 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:51.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.450299 17531 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:51.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.452194 17531 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data/instance:
06:04:51.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2034342c4c9d46e997d3eac7165cc92f"
06:04:51.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.452714 17531 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal/instance:
06:04:51.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2034342c4c9d46e997d3eac7165cc92f"
06:04:51.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.456955 17531 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.003s
06:04:51.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.460007 17546 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:51.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.461436 17531 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
06:04:51.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.461623 17531 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2034342c4c9d46e997d3eac7165cc92f"
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.461755 17531 fs_report.cc:389] FS layout report
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data/data
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:51.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:51.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.480216 17531 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.481179 17531 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.481432 17531 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:51.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.482187 17531 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
06:04:51.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.483639 17531 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:04:51.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.483718 17531 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:04:51.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.483788 17531 ts_tablet_manager.cc:616] Registered 0 tablets
06:04:51.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.483819 17531 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:04:51.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.496913 17531 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.2:39425
06:04:51.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.496968 17669 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.2:39425 every 8 connection(s)
06:04:51.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.498206 17531 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/data/info.pb
06:04:51.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.499967 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17531
06:04:51.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.500093 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-1/wal/instance
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.504179 17048 external_mini_cluster.cc:1373] Running /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:04:51.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/logs
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data/info.pb
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.3:0
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.3
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.3
06:04:51.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:51.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:51.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:51.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:51.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:51.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:04:51.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.512100 17672 heartbeater.cc:344] Connected to a master server at 127.16.166.61:34265
06:04:51.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.512120 17671 heartbeater.cc:344] Connected to a master server at 127.16.166.62:44597
06:04:51.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.512471 17672 heartbeater.cc:461] Registering TS with master...
06:04:51.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.512472 17671 heartbeater.cc:461] Registering TS with master...
06:04:51.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.513273 17671 heartbeater.cc:507] Master 127.16.166.62:44597 requested a full tablet report, sending...
06:04:51.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.513273 17672 heartbeater.cc:507] Master 127.16.166.61:34265 requested a full tablet report, sending...
06:04:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.515199 17182 ts_manager.cc:194] Registered new tserver with Master: 2034342c4c9d46e997d3eac7165cc92f (127.16.166.2:39425)
06:04:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.515190 17097 ts_manager.cc:194] Registered new tserver with Master: 2034342c4c9d46e997d3eac7165cc92f (127.16.166.2:39425)
06:04:51.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.516003 17182 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.166.2:45955
06:04:51.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.518590 17670 heartbeater.cc:344] Connected to a master server at 127.16.166.60:34011
06:04:51.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.518759 17670 heartbeater.cc:461] Registering TS with master...
06:04:51.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.519017 17670 heartbeater.cc:507] Master 127.16.166.60:34011 requested a full tablet report, sending...
06:04:51.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.520174 17266 ts_manager.cc:194] Registered new tserver with Master: 2034342c4c9d46e997d3eac7165cc92f (127.16.166.2:39425)
06:04:51.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.643046 17677 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
06:04:51.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.643292 17677 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:04:51.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.643338 17677 flags.cc:432] Enabled unsafe flag: --never_fsync=true
06:04:51.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.647087 17677 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
06:04:51.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.647219 17677 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.16.166.3
06:04:51.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.652321 17677 tablet_server_runner.cc:78] Tablet server non-default flags:
06:04:51.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.16.166.20:46131
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.16.166.3:0
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data/info.pb
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.16.166.3
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.16.166.62:44597,127.16.166.61:34265,127.16.166.60:34011
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.17677
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:04:51.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.16.166.3
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/logs
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5aabff03afe514f4e9286d8ef2d8bf6bed19fb06
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 12 Aug 2026 05:49:18 UTC on bdcb31816ec0
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17643
06:04:51.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.654047 17677 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:04:51.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.655539 17677 file_cache.cc:504] Constructed file cache file cache with capacity 419430
06:04:51.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.663815 17685 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
06:04:51.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.663815 17687 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
06:04:51.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:51.663962 17684 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
06:04:51.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.664041 17677 server_base.cc:1061] running on GCE node
06:04:51.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.665248 17677 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:04:51.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.666002 17677 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:04:51.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.669435 17677 hybrid_clock.cc:648] HybridClock initialized: now 1786514691669379 us; error 65 us; skew 500 ppm
06:04:51.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.672075 17677 webserver.cc:533] Webserver started at http://127.16.166.3:32951/ using document root <none> and password file <none>
06:04:51.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.672750 17677 fs_manager.cc:362] Metadata directory not provided
06:04:51.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.672816 17677 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:04:51.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.673000 17677 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
06:04:51.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.674731 17677 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data/instance:
06:04:51.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "54f38f40525444cca792a29197a0b5fd"
06:04:51.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.675201 17677 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal/instance:
06:04:51.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "54f38f40525444cca792a29197a0b5fd"
06:04:51.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.680456 17677 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.001s
06:04:51.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.684405 17695 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:04:51.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.686281 17677 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
06:04:51.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.686437 17677 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data,/tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal
06:04:51.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "54f38f40525444cca792a29197a0b5fd"
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:04:51 on dist-test-slave-btw8"
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.686538 17677 fs_report.cc:389] FS layout report
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data/data
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:04:51.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:04:51.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.711988 17677 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
06:04:51.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.712852 17677 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:04:51.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.713027 17677 kserver.cc:163] Server-wide thread pool size limit: 3276
06:04:51.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.713666 17677 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
06:04:51.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.714941 17677 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:04:51.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.715024 17677 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:04:51.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.715087 17677 ts_tablet_manager.cc:616] Registered 0 tablets
06:04:51.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.715111 17677 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:04:51.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.727694 17677 rpc_server.cc:307] RPC server started. Bound to: 127.16.166.3:43135
06:04:51.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.727813 17826 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.16.166.3:43135 every 8 connection(s)
06:04:51.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.729048 17677 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/data/info.pb
06:04:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.738606 17048 external_mini_cluster.cc:1435] Started /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu as pid 17677
06:04:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.738749 17048 external_mini_cluster.cc:1449] Reading /tmp/dist-test-taskCDPYZu/test-tmp/mini-kudu-cluster7728978594406930574/ts-2/wal/instance
06:04:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.742462 17827 heartbeater.cc:344] Connected to a master server at 127.16.166.60:34011
06:04:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.742761 17827 heartbeater.cc:461] Registering TS with master...
06:04:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.742846 17828 heartbeater.cc:344] Connected to a master server at 127.16.166.62:44597
06:04:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.742946 17828 heartbeater.cc:461] Registering TS with master...
06:04:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.743512 17827 heartbeater.cc:507] Master 127.16.166.60:34011 requested a full tablet report, sending...
06:04:51.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.743513 17828 heartbeater.cc:507] Master 127.16.166.62:44597 requested a full tablet report, sending...
06:04:51.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.744527 17829 heartbeater.cc:344] Connected to a master server at 127.16.166.61:34265
06:04:51.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.744591 17829 heartbeater.cc:461] Registering TS with master...
06:04:51.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.744808 17829 heartbeater.cc:507] Master 127.16.166.61:34265 requested a full tablet report, sending...
06:04:51.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.744853 17266 ts_manager.cc:194] Registered new tserver with Master: 54f38f40525444cca792a29197a0b5fd (127.16.166.3:43135)
06:04:51.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.745766 17097 ts_manager.cc:194] Registered new tserver with Master: 54f38f40525444cca792a29197a0b5fd (127.16.166.3:43135)
06:04:51.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.746037 17182 ts_manager.cc:194] Registered new tserver with Master: 54f38f40525444cca792a29197a0b5fd (127.16.166.3:43135)
06:04:51.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.746776 17182 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.16.166.3:52813
06:04:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.762986 17048 external_mini_cluster.cc:956] 3 TS(s) registered with all masters
06:04:51.764 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:04:51.766 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

06:04:51.777 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.16.166.62"
      port: 44597
    }
    bound_http_address {
      host: "127.16.166.62"
      port: 41109
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.16.166.61"
      port: 34265
    }
    bound_http_address {
      host: "127.16.166.61"
      port: 37649
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.16.166.60"
      port: 34011
    }
    bound_http_address {
      host: "127.16.166.60"
      port: 43799
    }
  }
}

06:04:51.781 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

06:04:51.785 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.16.166.1"
      port: 41933
    }
    bound_http_address {
      host: "127.16.166.1"
      port: 46559
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.16.166.2"
      port: 39425
    }
    bound_http_address {
      host: "127.16.166.2"
      port: 38457
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.16.166.3"
      port: 43135
    }
    bound_http_address {
      host: "127.16.166.3"
      port: 32951
    }
  }
}

06:04:51.785 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
06:04:51.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.800843 17348 catalog_manager.cc:1296] Loaded cluster ID: b9df872f22ae4ebcacbb2f5bdab1fa31
06:04:51.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.800977 17348 catalog_manager.cc:1608] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: loading cluster ID for follower catalog manager: success
06:04:51.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.803206 17348 catalog_manager.cc:1630] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: acquiring CA information for follower catalog manager: success
06:04:51.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.804893 17348 catalog_manager.cc:1658] T 00000000000000000000000000000000 P 0a5f6f379e2b47a4994258cdbe84663d: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
06:04:51.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.816857 17362 catalog_manager.cc:1296] Loaded cluster ID: b9df872f22ae4ebcacbb2f5bdab1fa31
06:04:51.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.816954 17362 catalog_manager.cc:1608] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: loading cluster ID for follower catalog manager: success
06:04:51.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.819797 17362 catalog_manager.cc:1630] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: acquiring CA information for follower catalog manager: success
06:04:51.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:51.821811 17362 catalog_manager.cc:1658] T 00000000000000000000000000000000 P 3777259a662241b1bc8f59d9a4ce85e1: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
06:04:52.016 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
06:04:52.083 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
06:04:52.281 [DEBUG - main] (Connection.java:748) [peer master-127.16.166.60:34011(127.16.166.60:34011)] connecting to peer
06:04:52.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.294651 17523 heartbeater.cc:499] Master 127.16.166.61:34265 was elected leader, sending a full tablet report...
06:04:52.342 [DEBUG - main] (Connection.java:748) [peer master-127.16.166.61:34265(127.16.166.61:34265)] connecting to peer
06:04:52.343 [DEBUG - main] (Connection.java:748) [peer master-127.16.166.62:44597(127.16.166.62:44597)] connecting to peer
06:04:52.364 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.16.166.60:34011(127.16.166.60:34011)] Successfully connected to peer
06:04:52.367 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.16.166.61:34265(127.16.166.61:34265)] Successfully connected to peer
06:04:52.367 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.16.166.62:44597(127.16.166.62:44597)] Successfully connected to peer
06:04:52.475 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.166.62
06:04:52.475 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.166.61
06:04:52.477 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.16.166.60
06:04:52.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.518350 17672 heartbeater.cc:499] Master 127.16.166.61:34265 was elected leader, sending a full tablet report...
06:04:52.740 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xc6343580, L:/127.0.0.1:36514 - R:/127.16.166.61:34265] using SASL/PLAIN
06:04:52.742 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xb4614f5e, L:/127.0.0.1:59436 - R:/127.16.166.62:44597] using SASL/PLAIN
06:04:52.743 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0xb484df3e, L:/127.0.0.1:40618 - R:/127.16.166.60:34011] using SASL/PLAIN
06:04:52.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.749956 17829 heartbeater.cc:499] Master 127.16.166.61:34265 was elected leader, sending a full tablet report...
06:04:52.788 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
06:04:52.789 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=562), Traces: [0ms] refreshing cache from master, [35ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.166.60:34011, [107ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.166.61:34265, [109ms] Sub RPC ConnectToMaster: sending RPC to server master-127.16.166.62:44597, [525ms] Sub RPC ConnectToMaster: received response from server master-127.16.166.62:44597: OK, [526ms] Sub RPC ConnectToMaster: received response from server master-127.16.166.60:34011: OK, [526ms] Sub RPC ConnectToMaster: received response from server master-127.16.166.61:34265: OK, deferred=null) after lookup
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.858024 17182 catalog_manager.cc:2303] Servicing CreateTable request from {username='slave'} at 127.0.0.1:36514:
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786514689273"
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
06:04:52.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
06:04:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:52.859875 17182 catalog_manager.cc:7119] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1786514689273 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
06:04:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.890226 17599 tablet_service.cc:1511] Processing CreateTablet for tablet bb005d6493404de4a46fec0cbc710639 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786514689273 [id=4b6731c8d9ac455d864d23b4eecb05a0]), partition=RANGE (key) PARTITION UNBOUNDED
06:04:52.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.891949 17599 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bb005d6493404de4a46fec0cbc710639. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.894694 17748 tablet_service.cc:1511] Processing CreateTablet for tablet bb005d6493404de4a46fec0cbc710639 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786514689273 [id=4b6731c8d9ac455d864d23b4eecb05a0]), partition=RANGE (key) PARTITION UNBOUNDED
06:04:52.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.896052 17748 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bb005d6493404de4a46fec0cbc710639. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:52.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.902901 17863 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Bootstrap starting.
06:04:52.903 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 4b6731c8d9ac455d864d23b4eecb05a0
06:04:52.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.904366 17447 tablet_service.cc:1511] Processing CreateTablet for tablet bb005d6493404de4a46fec0cbc710639 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786514689273 [id=4b6731c8d9ac455d864d23b4eecb05a0]), partition=RANGE (key) PARTITION UNBOUNDED
06:04:52.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.905059 17864 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Bootstrap starting.
06:04:52.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.905712 17447 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet bb005d6493404de4a46fec0cbc710639. 1 dirs total, 0 dirs full, 0 dirs failed
06:04:52.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.907815 17863 tablet_bootstrap.cc:654] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Neither blocks nor log segments found. Creating new log.
06:04:52.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.907866 17864 tablet_bootstrap.cc:654] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Neither blocks nor log segments found. Creating new log.
06:04:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.909258 17863 log.cc:826] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Log is configured to *not* fsync() on all Append() calls
06:04:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.909348 17864 log.cc:826] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Log is configured to *not* fsync() on all Append() calls
06:04:52.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.911755 17863 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: No bootstrap required, opened a new log
06:04:52.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.911756 17864 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: No bootstrap required, opened a new log
06:04:52.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.912051 17864 ts_tablet_manager.cc:1403] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Time spent bootstrapping tablet: real 0.007s	user 0.006s	sys 0.000s
06:04:52.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.912053 17863 ts_tablet_manager.cc:1403] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Time spent bootstrapping tablet: real 0.009s	user 0.006s	sys 0.000s
06:04:52.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.913931 17867 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Bootstrap starting.
06:04:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.915948 17864 raft_consensus.cc:359] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.916324 17864 raft_consensus.cc:385] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.916388 17864 raft_consensus.cc:740] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 54f38f40525444cca792a29197a0b5fd, State: Initialized, Role: FOLLOWER
06:04:52.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.917119 17864 consensus_queue.cc:260] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [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: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.917537 17867 tablet_bootstrap.cc:654] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Neither blocks nor log segments found. Creating new log.
06:04:52.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.918263 17864 ts_tablet_manager.cc:1434] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Time spent starting tablet: real 0.006s	user 0.006s	sys 0.000s
06:04:52.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.918677 17867 log.cc:826] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Log is configured to *not* fsync() on all Append() calls
06:04:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.918663 17863 raft_consensus.cc:359] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.922101 17863 raft_consensus.cc:385] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.922220 17863 raft_consensus.cc:740] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2034342c4c9d46e997d3eac7165cc92f, State: Initialized, Role: FOLLOWER
06:04:52.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.922906 17863 consensus_queue.cc:260] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [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: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.924196 17863 ts_tablet_manager.cc:1434] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Time spent starting tablet: real 0.012s	user 0.004s	sys 0.003s
06:04:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.929001 17867 tablet_bootstrap.cc:492] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: No bootstrap required, opened a new log
06:04:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.929378 17867 ts_tablet_manager.cc:1403] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Time spent bootstrapping tablet: real 0.016s	user 0.007s	sys 0.000s
06:04:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.934085 17867 raft_consensus.cc:359] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.934367 17867 raft_consensus.cc:385] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:04:52.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.934413 17867 raft_consensus.cc:740] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7d489b09dbb544bebc1e1349110e7854, State: Initialized, Role: FOLLOWER
06:04:52.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.934966 17867 consensus_queue.cc:260] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [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: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:52.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:52.936298 17867 ts_tablet_manager.cc:1434] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Time spent starting tablet: real 0.007s	user 0.005s	sys 0.002s
06:04:52.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:52.985972 17830 tablet.cc:2406] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:04:53.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:53.001075 17673 tablet.cc:2406] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:04:53.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:04:53.025411 17525 tablet.cc:2406] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:04:53.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.149487 17871 raft_consensus.cc:493] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
06:04:53.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.149756 17871 raft_consensus.cc:515] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:53.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.151499 17871 leader_election.cc:290] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 2034342c4c9d46e997d3eac7165cc92f (127.16.166.2:39425), 54f38f40525444cca792a29197a0b5fd (127.16.166.3:43135)
06:04:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.157444 17770 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bb005d6493404de4a46fec0cbc710639" candidate_uuid: "7d489b09dbb544bebc1e1349110e7854" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "54f38f40525444cca792a29197a0b5fd" is_pre_election: true
06:04:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.157801 17622 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bb005d6493404de4a46fec0cbc710639" candidate_uuid: "7d489b09dbb544bebc1e1349110e7854" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2034342c4c9d46e997d3eac7165cc92f" is_pre_election: true
06:04:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.157884 17770 raft_consensus.cc:2468] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 7d489b09dbb544bebc1e1349110e7854 in term 0.
06:04:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.158092 17622 raft_consensus.cc:2468] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 7d489b09dbb544bebc1e1349110e7854 in term 0.
06:04:53.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.158608 17396 leader_election.cc:304] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [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: 54f38f40525444cca792a29197a0b5fd, 7d489b09dbb544bebc1e1349110e7854; no voters: 
06:04:53.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.159010 17871 raft_consensus.cc:2804] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Leader pre-election won for term 1
06:04:53.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.159188 17871 raft_consensus.cc:493] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
06:04:53.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.159261 17871 raft_consensus.cc:3060] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 0 FOLLOWER]: Advancing to term 1
06:04:53.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.160635 17871 raft_consensus.cc:515] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:53.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.161219 17871 leader_election.cc:290] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [CANDIDATE]: Term 1 election: Requested vote from peers 2034342c4c9d46e997d3eac7165cc92f (127.16.166.2:39425), 54f38f40525444cca792a29197a0b5fd (127.16.166.3:43135)
06:04:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.161963 17622 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bb005d6493404de4a46fec0cbc710639" candidate_uuid: "7d489b09dbb544bebc1e1349110e7854" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2034342c4c9d46e997d3eac7165cc92f"
06:04:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.162259 17622 raft_consensus.cc:3060] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 0 FOLLOWER]: Advancing to term 1
06:04:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.162155 17770 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "bb005d6493404de4a46fec0cbc710639" candidate_uuid: "7d489b09dbb544bebc1e1349110e7854" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "54f38f40525444cca792a29197a0b5fd"
06:04:53.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.162564 17770 raft_consensus.cc:3060] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 0 FOLLOWER]: Advancing to term 1
06:04:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.163576 17622 raft_consensus.cc:2468] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 7d489b09dbb544bebc1e1349110e7854 in term 1.
06:04:53.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.163640 17770 raft_consensus.cc:2468] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 7d489b09dbb544bebc1e1349110e7854 in term 1.
06:04:53.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.164079 17396 leader_election.cc:304] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [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: 54f38f40525444cca792a29197a0b5fd, 7d489b09dbb544bebc1e1349110e7854; no voters: 
06:04:53.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.164494 17871 raft_consensus.cc:2804] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 1 FOLLOWER]: Leader election won for term 1
06:04:53.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.164785 17871 raft_consensus.cc:697] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [term 1 LEADER]: Becoming Leader. State: Replica: 7d489b09dbb544bebc1e1349110e7854, State: Running, Role: LEADER
06:04:53.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.165208 17871 consensus_queue.cc:237] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [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: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } }
06:04:53.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.171319 17178 catalog_manager.cc:5739] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 reported cstate change: term changed from 0 to 1, leader changed from <none> to 7d489b09dbb544bebc1e1349110e7854 (127.16.166.1). New cstate: current_term: 1 leader_uuid: "7d489b09dbb544bebc1e1349110e7854" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7d489b09dbb544bebc1e1349110e7854" member_type: VOTER last_known_addr { host: "127.16.166.1" port: 41933 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 } health_report { overall_health: UNKNOWN } } }
06:04:53.293 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet bb005d6493404de4a46fec0cbc710639 for table 'org.apache.kudu.client.TestHybridTime-1786514689273' with partition [<start>, <end>)
06:04:53.303 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299990, tablet=bb005d6493404de4a46fec0cbc710639@[2034342c4c9d46e997d3eac7165cc92f(127.16.166.2:39425),54f38f40525444cca792a29197a0b5fd(127.16.166.3:43135),7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)[L]]}]
06:04:53.305 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=25), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.16.166.61:34265, [11ms] Sub RPC GetTableLocations: received response from server master-127.16.166.61:34265: OK, deferred=null) after lookup
06:04:53.317 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)] connecting to peer
06:04:53.320 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)] Successfully connected to peer
06:04:53.395 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0xc01e4a5d, L:/127.0.0.1:58448 - R:/127.16.166.1:41933] using TOKEN/null
06:04:53.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.405179 17770 raft_consensus.cc:1275] T bb005d6493404de4a46fec0cbc710639 P 54f38f40525444cca792a29197a0b5fd [term 1 FOLLOWER]: Refusing update from remote peer 7d489b09dbb544bebc1e1349110e7854: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:04:53.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.405287 17622 raft_consensus.cc:1275] T bb005d6493404de4a46fec0cbc710639 P 2034342c4c9d46e997d3eac7165cc92f [term 1 FOLLOWER]: Refusing update from remote peer 7d489b09dbb544bebc1e1349110e7854: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:04:53.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.406409 17875 consensus_queue.cc:1048] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [LEADER]: Connected to new peer: Peer: permanent_uuid: "2034342c4c9d46e997d3eac7165cc92f" member_type: VOTER last_known_addr { host: "127.16.166.2" port: 39425 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:04:53.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.406751 17871 consensus_queue.cc:1048] T bb005d6493404de4a46fec0cbc710639 P 7d489b09dbb544bebc1e1349110e7854 [LEADER]: Connected to new peer: Peer: permanent_uuid: "54f38f40525444cca792a29197a0b5fd" member_type: VOTER last_known_addr { host: "127.16.166.3" port: 43135 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:04:53.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.426865 17881 mvcc.cc:204] Tried to move back new op lower bound from 7317564184176017408 to 7317564183209484288. Current Snapshot: MvccSnapshot[applied={T|T < 7317564184176017408}]
06:04:53.478 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.495 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.513 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.518 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@813116929(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:04:53.533 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.533 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@631884457(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:04:53.543 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.543 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@106585591(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:04:53.554 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:04:53.615 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.624 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317564204656017409) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.630 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317564204656017413) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.636 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317564204656017417) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.642 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317564204656017421) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.648 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317564204656017427) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.654 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317564204656017431) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.661 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317564204656017432) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786514689273, tablet=bb005d6493404de4a46fec0cbc710639, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:04:53.665 [DEBUG - main] (Connection.java:575) [peer master-127.16.166.62:44597(127.16.166.62:44597)] disconnecting while in state READY
06:04:53.672 [DEBUG - main] (Connection.java:575) [peer master-127.16.166.60:34011(127.16.166.60:34011)] disconnecting while in state READY
06:04:53.672 [DEBUG - main] (Connection.java:575) [peer master-127.16.166.61:34265(127.16.166.61:34265)] disconnecting while in state READY
06:04:53.673 [DEBUG - main] (Connection.java:575) [peer 7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)] disconnecting while in state READY
06:04:53.678 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.16.166.61:34265(127.16.166.61:34265)] handling channelInactive
06:04:53.678 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.16.166.60:34011(127.16.166.60:34011)] handling channelInactive
06:04:53.678 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.16.166.62:44597(127.16.166.62:44597)] handling channelInactive
06:04:53.679 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.16.166.60:34011(127.16.166.60:34011)] cleaning up while in state READY due to: connection closed
06:04:53.679 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.16.166.61:34265(127.16.166.61:34265)] cleaning up while in state READY due to: connection closed
06:04:53.679 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.16.166.62:44597(127.16.166.62:44597)] cleaning up while in state READY due to: connection closed
06:04:53.680 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
06:04:53.693 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)] handling channelInactive
06:04:53.693 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 7d489b09dbb544bebc1e1349110e7854(127.16.166.1:41933)] cleaning up while in state READY due to: connection closed
06:04:53.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.692900 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17379
06:04:53.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.718943 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17531
06:04:53.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.755766 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17677
06:04:53.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.769831 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17061
06:04:53.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.785686 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17145
06:04:53.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:04:53.800043 17048 external_mini_cluster.cc:1671] Killing /tmp/dist-test-taskCDPYZu/build/debug/bin/kudu with pid 17227
06:04:53.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:04:53Z chronyd exiting

Time: 4.464

OK (1 test)

