JUnit version 4.13.2
.14:21:15.865 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783520475855
14:21:15.892 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:21:15.929 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:21:15.936 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task8iUlhY/test-tmp
14:21:15.960 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
14:21:15.963 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task8iUlhY/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
14:21:16.173 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:21:16.186 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:21:16.187 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:21:16.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.188702  8160 mini_oidc.cc:150] Starting JWKS server
14:21:16.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.189471  8160 webserver.cc:533] Webserver started at http://127.0.0.1:39413/ using document root <none> and password file <none>
14:21:16.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.189574  8160 mini_oidc.cc:186] Starting OIDC Discovery server
14:21:16.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.189741  8160 webserver.cc:533] Webserver started at http://127.0.0.1:36355/ using document root <none> and password file <none>
14:21:16.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:16Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:21:16.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:16Z Disabled control of system clock
14:21:16.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.202593  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal
14:21:16.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data
14:21:16.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/logs
14:21:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data/info.pb
14:21:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:21:16.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.62:38865
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.62
14:21:16.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json with env {}
14:21:16.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.301489  8171 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.301674  8171 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.301707  8171 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303659  8171 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:21:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303727  8171 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303750  8171 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:21:16.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303768  8171 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:21:16.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303786  8171 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:21:16.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.303803  8171 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39413/jwks.json
14:21:16.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.305871  8171 master_runner.cc:387] Master server non-default flags:
14:21:16.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data
14:21:16.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal
14:21:16.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.62:38865
14:21:16.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data/info.pb
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.62
14:21:16.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8171
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/logs
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.306143  8171 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.306393  8171 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.308990  8176 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
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.308974  8177 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
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.308977  8179 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
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.309091  8171 server_base.cc:1061] running on GCE node
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.309377  8171 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.309562  8171 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.310688  8171 hybrid_clock.cc:648] HybridClock initialized: now 1783520476310633 us; error 68 us; skew 500 ppm
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.312004  8171 webserver.cc:533] Webserver started at http://127.7.248.62:34103/ using document root <none> and password file <none>
14:21:16.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.312219  8171 fs_manager.cc:362] Metadata directory not provided
14:21:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.312275  8171 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.312371  8171 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.313483  8171 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data/instance:
14:21:16.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea"
14:21:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.313854  8171 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal/instance:
14:21:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea"
14:21:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.315366  8171 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.316198  8185 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.316332  8171 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.316382  8171 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea"
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.316421  8171 fs_report.cc:389] FS layout report
14:21:16.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal
14:21:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal
14:21:16.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data/data
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.342257  8171 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.342530  8171 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
14:21:16.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.342628  8171 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.346735  8171 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.62:38865
14:21:16.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.346766  8237 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.62:38865 every 8 connection(s)
14:21:16.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.347036  8171 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/data/info.pb
14:21:16.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.347565  8238 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:16.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.349203  8238 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.354022  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8171
14:21:16.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.354137  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-0/wal/instance
14:21:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.354977  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal
14:21:16.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data
14:21:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/logs
14:21:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data/info.pb
14:21:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.61:43847
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.61
14:21:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json with env {}
14:21:16.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.358139  8238 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.358600  8186 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.248.61:43847: connect: Connection refused (error 111)
14:21:16.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.359082  8238 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.61:43847: Network error: Client connection negotiation failed: client connection to 127.7.248.61:43847: connect: Connection refused (error 111)
14:21:16.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.408279  8238 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } attempt: 1
14:21:16.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.409303  8238 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.61:43847: Network error: Client connection negotiation failed: client connection to 127.7.248.61:43847: connect: Connection refused (error 111)
14:21:16.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.436019  8242 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.436230  8242 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.436282  8242 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438635  8242 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:21:16.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438686  8242 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438702  8242 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:21:16.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438715  8242 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:21:16.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438730  8242 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:21:16.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.438741  8242 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39413/jwks.json
14:21:16.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.441061  8242 master_runner.cc:387] Master server non-default flags:
14:21:16.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data
14:21:16.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal
14:21:16.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.61:43847
14:21:16.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json
14:21:16.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data/info.pb
14:21:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.61
14:21:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8242
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/logs
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.441334  8242 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.441608  8242 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.444636  8248 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
14:21:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.444808  8249 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
14:21:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.444936  8251 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
14:21:16.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.445863  8242 server_base.cc:1061] running on GCE node
14:21:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.446081  8242 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.446332  8242 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.447489  8242 hybrid_clock.cc:648] HybridClock initialized: now 1783520476447460 us; error 51 us; skew 500 ppm
14:21:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.448837  8242 webserver.cc:533] Webserver started at http://127.7.248.61:33965/ using document root <none> and password file <none>
14:21:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.449041  8242 fs_manager.cc:362] Metadata directory not provided
14:21:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.449093  8242 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.449223  8242 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.450367  8242 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data/instance:
14:21:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "749af28f55864d5eba3aa958778edb72"
14:21:16.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.450758  8242 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal/instance:
14:21:16.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "749af28f55864d5eba3aa958778edb72"
14:21:16.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.452334  8242 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
14:21:16.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.453217  8257 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.453380  8242 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.453431  8242 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal
14:21:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "749af28f55864d5eba3aa958778edb72"
14:21:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.453488  8242 fs_report.cc:389] FS layout report
14:21:16.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal
14:21:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal
14:21:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data/data
14:21:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.466141  8242 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.466403  8242 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
14:21:16.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.466496  8242 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.471650  8242 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.61:43847
14:21:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.471674  8309 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.61:43847 every 8 connection(s)
14:21:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.472004  8242 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/data/info.pb
14:21:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.472311  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8242
14:21:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.472384  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-1/wal/instance
14:21:16.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.472713  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/logs
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data/info.pb
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.60:33885
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.60
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json with env {}
14:21:16.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.477456  8238 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } attempt: 2
14:21:16.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.478307  8310 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:16.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.480635  8310 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.485913  8238 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.486621  8238 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.60:33885: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.486920  8310 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.490091  8310 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.490456  8259 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.492496  8310 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.60:33885: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.529780  8238 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } attempt: 1
14:21:16.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.530570  8238 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.60:33885: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.541716  8310 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } attempt: 1
14:21:16.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.542670  8310 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.60:33885: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.556828  8312 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.556973  8312 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.556993  8312 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558509  8312 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:21:16.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558549  8312 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558563  8312 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:21:16.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558575  8312 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:21:16.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558588  8312 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:21:16.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.558598  8312 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39413/jwks.json
14:21:16.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.560189  8312 master_runner.cc:387] Master server non-default flags:
14:21:16.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:21:16.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.60:33885
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39413/jwks.json
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data/info.pb
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.60
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8312
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/logs
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.560366  8312 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.560535  8312 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.562836  8320 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
14:21:16.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.562906  8323 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
14:21:16.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.563055  8321 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
14:21:16.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.563975  8312 server_base.cc:1061] running on GCE node
14:21:16.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.564261  8312 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.564502  8312 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.565668  8312 hybrid_clock.cc:648] HybridClock initialized: now 1783520476565645 us; error 36 us; skew 500 ppm
14:21:16.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.566936  8312 webserver.cc:533] Webserver started at http://127.7.248.60:33525/ using document root <none> and password file <none>
14:21:16.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.567152  8312 fs_manager.cc:362] Metadata directory not provided
14:21:16.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.567211  8312 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.567318  8312 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.568324  8312 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data/instance:
14:21:16.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44186f48109f4294bf83433b0c9e5012"
14:21:16.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.568691  8312 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal/instance:
14:21:16.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44186f48109f4294bf83433b0c9e5012"
14:21:16.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.570089  8312 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.570842  8329 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.571038  8312 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.001s	sys 0.000s
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.571100  8312 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "44186f48109f4294bf83433b0c9e5012"
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.571148  8312 fs_report.cc:389] FS layout report
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data/data
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.577726  8238 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } attempt: 2
14:21:16.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.578430  8238 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.248.60:33885: Network error: Client connection negotiation failed: client connection to 127.7.248.60:33885: connect: Connection refused (error 111)
14:21:16.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.586733  8312 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.586956  8312 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
14:21:16.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.587038  8312 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.590662  8312 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.60:33885
14:21:16.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.590704  8381 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.60:33885 every 8 connection(s)
14:21:16.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.591060  8312 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/data/info.pb
14:21:16.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.591615  8382 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:16.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.593046  8382 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.597438  8382 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.599042  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8312
14:21:16.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.599121  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/master-2/wal/instance
14:21:16.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.601043  8382 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } has no permanent_uuid. Determining permanent_uuid...
14:21:16.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.605657  8382 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: Bootstrap starting.
14:21:16.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.606307  8382 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: Neither blocks nor log segments found. Creating new log.
14:21:16.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.606622  8382 log.cc:826] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: Log is configured to *not* fsync() on all Append() calls
14:21:16.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.607379  8382 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: No bootstrap required, opened a new log
14:21:16.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.609483  8382 raft_consensus.cc:359] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.609939  8382 raft_consensus.cc:385] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:16.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.610211  8382 raft_consensus.cc:740] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 44186f48109f4294bf83433b0c9e5012, State: Initialized, Role: FOLLOWER
14:21:16.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.610546  8382 consensus_queue.cc:260] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.610842  8382 sys_catalog.cc:565] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: configured and running, proceeding with master startup.
14:21:16.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.610808  8310 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } attempt: 2
14:21:16.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.611450  8389 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.611855  8389 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.614969  8310 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: Bootstrap starting.
14:21:16.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.614043  8312 master_runner.cc:187] Error getting master registration for 127.7.248.62:38865: OK, instance_id { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" instance_seqno: 1783520476345670 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:21:16.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.615664  8310 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: Neither blocks nor log segments found. Creating new log.
14:21:16.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.615669  8312 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:21:16.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.615924  8310 log.cc:826] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: Log is configured to *not* fsync() on all Append() calls
14:21:16.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.612939  8400 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:21:16.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.616601  8400 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:21:16.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.618646  8310 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: No bootstrap required, opened a new log
14:21:16.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.620940  8310 raft_consensus.cc:359] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621081  8310 raft_consensus.cc:385] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:16.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621116  8310 raft_consensus.cc:740] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 749af28f55864d5eba3aa958778edb72, State: Initialized, Role: FOLLOWER
14:21:16.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621208  8310 consensus_queue.cc:260] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621508  8310 sys_catalog.cc:565] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: configured and running, proceeding with master startup.
14:21:16.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621526  8403 sys_catalog.cc:455] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.621622  8403 sys_catalog.cc:458] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.623373  8414 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:21:16.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.623662  8414 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:21:16.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.623409  8242 master_runner.cc:187] Error getting master registration for 127.7.248.62:38865: OK, instance_id { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" instance_seqno: 1783520476345670 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:21:16.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.625110  8242 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:21:16.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.685603  8238 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } attempt: 3
14:21:16.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.690582  8238 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: Bootstrap starting.
14:21:16.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.691293  8238 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: Neither blocks nor log segments found. Creating new log.
14:21:16.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.691579  8238 log.cc:826] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: Log is configured to *not* fsync() on all Append() calls
14:21:16.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.692489  8238 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: No bootstrap required, opened a new log
14:21:16.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.694638  8238 raft_consensus.cc:359] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.694756  8238 raft_consensus.cc:385] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:16.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.694782  8238 raft_consensus.cc:740] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f8fb6730ae2b4384bd92f94cb8ff79ea, State: Initialized, Role: FOLLOWER
14:21:16.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.694872  8238 consensus_queue.cc:260] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.695144  8238 sys_catalog.cc:565] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: configured and running, proceeding with master startup.
14:21:16.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.695711  8417 sys_catalog.cc:455] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.696026  8417 sys_catalog.cc:458] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.696990  8428 catalog_manager.cc:1594] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:21:16.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.697278  8428 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:21:16.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.699074  8171 master_runner.cc:264] No leader master found from master f8fb6730ae2b4384bd92f94cb8ff79ea
14:21:16.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.699116  8171 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:21:16.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.717118  8263 tablet.cc:2406] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:16.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.778527  8389 raft_consensus.cc:493] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:21:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.778654  8389 raft_consensus.cc:515] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.778863  8389 leader_election.cc:290] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers f8fb6730ae2b4384bd92f94cb8ff79ea (127.7.248.62:38865), 749af28f55864d5eba3aa958778edb72 (127.7.248.61:43847)
14:21:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779217  8284 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "44186f48109f4294bf83433b0c9e5012" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "749af28f55864d5eba3aa958778edb72" is_pre_election: true
14:21:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779351  8284 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 44186f48109f4294bf83433b0c9e5012 in term 0.
14:21:16.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779549  8330 leader_election.cc:304] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [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: 44186f48109f4294bf83433b0c9e5012, 749af28f55864d5eba3aa958778edb72; no voters: 
14:21:16.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779680  8389 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:21:16.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779723  8389 raft_consensus.cc:493] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:21:16.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.779744  8389 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 0 FOLLOWER]: Advancing to term 1
14:21:16.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.780635  8389 raft_consensus.cc:515] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.780782  8389 leader_election.cc:290] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [CANDIDATE]: Term 1 election: Requested vote from peers f8fb6730ae2b4384bd92f94cb8ff79ea (127.7.248.62:38865), 749af28f55864d5eba3aa958778edb72 (127.7.248.61:43847)
14:21:16.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.780717  8212 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "44186f48109f4294bf83433b0c9e5012" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" is_pre_election: true
14:21:16.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.780872  8212 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 44186f48109f4294bf83433b0c9e5012 in term 0.
14:21:16.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.780992  8284 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "44186f48109f4294bf83433b0c9e5012" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "749af28f55864d5eba3aa958778edb72"
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.781055  8284 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 0 FOLLOWER]: Advancing to term 1
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.781114  8212 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "44186f48109f4294bf83433b0c9e5012" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea"
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.781168  8212 raft_consensus.cc:3060] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 0 FOLLOWER]: Advancing to term 1
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.781848  8284 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 44186f48109f4294bf83433b0c9e5012 in term 1.
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.781978  8212 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 44186f48109f4294bf83433b0c9e5012 in term 1.
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782011  8330 leader_election.cc:304] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [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: 44186f48109f4294bf83433b0c9e5012, 749af28f55864d5eba3aa958778edb72; no voters: 
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782094  8389 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 1 FOLLOWER]: Leader election won for term 1
14:21:16.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782243  8389 raft_consensus.cc:697] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [term 1 LEADER]: Becoming Leader. State: Replica: 44186f48109f4294bf83433b0c9e5012, State: Running, Role: LEADER
14:21:16.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782322  8389 consensus_queue.cc:237] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [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: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } }
14:21:16.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782680  8389 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 44186f48109f4294bf83433b0c9e5012. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782742  8389 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: This master's current role is: LEADER
14:21:16.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.782951  8432 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:21:16.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.783154  8432 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:21:16.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.784861  8284 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [term 1 FOLLOWER]: Refusing update from remote peer 44186f48109f4294bf83433b0c9e5012: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:21:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.785454  8389 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [LEADER]: Connected to new peer: Peer: permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.785797  8212 raft_consensus.cc:1275] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [term 1 FOLLOWER]: Refusing update from remote peer 44186f48109f4294bf83433b0c9e5012: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:21:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.786945  8389 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:16.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.786968  8403 sys_catalog.cc:455] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 44186f48109f4294bf83433b0c9e5012. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.787066  8403 sys_catalog.cc:458] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.787940  8417 sys_catalog.cc:455] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: SysCatalogTable state changed. Reason: New leader 44186f48109f4294bf83433b0c9e5012. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.788033  8417 sys_catalog.cc:458] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.795049  8433 mvcc.cc:204] Tried to move back new op lower bound from 7305299872908775424 to 7305299872900968448. Current Snapshot: MvccSnapshot[applied={T|T < 7305299872908775424}]
14:21:16.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.795816  8389 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.795894  8389 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: This master's current role is: LEADER
14:21:16.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.797243  8403 sys_catalog.cc:455] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.797335  8403 sys_catalog.cc:458] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72 [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.798921  8389 sys_catalog.cc:455] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.799005  8389 sys_catalog.cc:458] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012 [sys.catalog]: This master's current role is: LEADER
14:21:16.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.799407  8417 sys_catalog.cc:455] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "44186f48109f4294bf83433b0c9e5012" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f8fb6730ae2b4384bd92f94cb8ff79ea" member_type: VOTER last_known_addr { host: "127.7.248.62" port: 38865 } } peers { permanent_uuid: "749af28f55864d5eba3aa958778edb72" member_type: VOTER last_known_addr { host: "127.7.248.61" port: 43847 } } peers { permanent_uuid: "44186f48109f4294bf83433b0c9e5012" member_type: VOTER last_known_addr { host: "127.7.248.60" port: 33885 } } }
14:21:16.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.799489  8417 sys_catalog.cc:458] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea [sys.catalog]: This master's current role is: FOLLOWER
14:21:16.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.800172  8432 catalog_manager.cc:1383] Generated new cluster ID: 6172eb04d98e461ea150561cbfd88dc3
14:21:16.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.800217  8432 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:21:16.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.807086  8436 mvcc.cc:204] Tried to move back new op lower bound from 7305299872908775424 to 7305299872900968448. Current Snapshot: MvccSnapshot[applied={T|T < 7305299872908775424 or (T in {7305299872908775424})}]
14:21:16.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.830863  8432 catalog_manager.cc:1406] Generated new certificate authority record
14:21:16.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.831882  8432 catalog_manager.cc:1540] Loading token signing keys...
14:21:16.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.840571  8432 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 44186f48109f4294bf83433b0c9e5012: Generated new TSK 0
14:21:16.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.841025  8432 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:21:16.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.853221  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/logs
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data/info.pb
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.1:0
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.1
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.1
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:21:16.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.950255  8442 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:16.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.950446  8442 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:16.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.950475  8442 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:16.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.952183  8442 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:16.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.952257  8442 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.248.1
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.953929  8442 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.1:0
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data/info.pb
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.1
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8442
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.1
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/logs
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:16.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.954186  8442 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.954443  8442 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.957254  8450 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
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.957798  8448 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
14:21:16.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:16.958010  8447 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
14:21:16.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.959031  8442 server_base.cc:1061] running on GCE node
14:21:16.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.959200  8442 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:16.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.959425  8442 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:16.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.960563  8442 hybrid_clock.cc:648] HybridClock initialized: now 1783520476960542 us; error 38 us; skew 500 ppm
14:21:16.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.961606  8442 webserver.cc:533] Webserver started at http://127.7.248.1:40159/ using document root <none> and password file <none>
14:21:16.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.961822  8442 fs_manager.cc:362] Metadata directory not provided
14:21:16.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.961884  8442 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:16.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.961988  8442 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.962883  8442 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data/instance:
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "abeb7ec520d04c30bd66599f988e29ed"
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.963244  8442 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal/instance:
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "abeb7ec520d04c30bd66599f988e29ed"
14:21:16.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.964660  8442 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:21:16.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.965405  8456 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:16.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.965603  8442 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:16.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.965667  8442 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "abeb7ec520d04c30bd66599f988e29ed"
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:16 on dist-test-slave-63nk"
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.965719  8442 fs_report.cc:389] FS layout report
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data/data
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:16.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:16.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.974274  8442 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:16.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.974604  8442 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
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.974727  8442 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.974953  8442 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.975332  8442 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.975569  8442 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.975641  8442 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:16.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.975664  8442 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:16.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.981803  8442 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.1:45125
14:21:16.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.981854  8569 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.1:45125 every 8 connection(s)
14:21:16.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.982144  8442 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/data/info.pb
14:21:16.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.985455  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8442
14:21:16.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.985543  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-0/wal/instance
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.987534  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:16.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/logs
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data/info.pb
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:16.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.2:0
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.2
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.2
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988289  8570 heartbeater.cc:344] Connected to a master server at 127.7.248.60:33885
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988371  8570 heartbeater.cc:461] Registering TS with master...
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988590  8570 heartbeater.cc:507] Master 127.7.248.60:33885 requested a full tablet report, sending...
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988863  8571 heartbeater.cc:344] Connected to a master server at 127.7.248.62:38865
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988911  8571 heartbeater.cc:461] Registering TS with master...
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.988989  8571 heartbeater.cc:507] Master 127.7.248.62:38865 requested a full tablet report, sending...
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989022  8346 ts_manager.cc:194] Registered new tserver with Master: abeb7ec520d04c30bd66599f988e29ed (127.7.248.1:45125)
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989234  8572 heartbeater.cc:344] Connected to a master server at 127.7.248.61:43847
14:21:16.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989262  8202 ts_manager.cc:194] Registered new tserver with Master: abeb7ec520d04c30bd66599f988e29ed (127.7.248.1:45125)
14:21:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989289  8572 heartbeater.cc:461] Registering TS with master...
14:21:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989380  8572 heartbeater.cc:507] Master 127.7.248.61:43847 requested a full tablet report, sending...
14:21:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989724  8274 ts_manager.cc:194] Registered new tserver with Master: abeb7ec520d04c30bd66599f988e29ed (127.7.248.1:45125)
14:21:16.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:16.989959  8346 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.248.1:33259
14:21:17.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.064352  8577 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:17.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.064500  8577 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:17.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.064518  8577 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:17.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.065961  8577 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:17.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.066011  8577 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.248.2
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.067415  8577 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:17.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.2:0
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data/info.pb
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.2
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8577
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.2
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/logs
14:21:17.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:17.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.067579  8577 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.067750  8577 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.069907  8585 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
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.069941  8583 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
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.069921  8582 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
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.070392  8577 server_base.cc:1061] running on GCE node
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.070519  8577 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:17.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.070762  8577 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:17.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.071904  8577 hybrid_clock.cc:648] HybridClock initialized: now 1783520477071880 us; error 41 us; skew 500 ppm
14:21:17.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.073091  8577 webserver.cc:533] Webserver started at http://127.7.248.2:36867/ using document root <none> and password file <none>
14:21:17.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.073242  8577 fs_manager.cc:362] Metadata directory not provided
14:21:17.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.073274  8577 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:17.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.073374  8577 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.074180  8577 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data/instance:
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27cfec9ef9ce4d03b2eb445130ca1255"
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.074435  8577 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal/instance:
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27cfec9ef9ce4d03b2eb445130ca1255"
14:21:17.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.075703  8577 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.076506  8591 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.076689  8577 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.076748  8577 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27cfec9ef9ce4d03b2eb445130ca1255"
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.076788  8577 fs_report.cc:389] FS layout report
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data/data
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:17.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:17.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:17.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:17.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:17.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:17.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.086712  8577 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.086943  8577 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
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087023  8577 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087184  8577 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087422  8577 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087443  8577 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087464  8577 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:17.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.087476  8577 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:17.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.093094  8577 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.2:33431
14:21:17.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.093168  8704 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.2:33431 every 8 connection(s)
14:21:17.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.093369  8577 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/data/info.pb
14:21:17.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.098543  8706 heartbeater.cc:344] Connected to a master server at 127.7.248.62:38865
14:21:17.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.098644  8706 heartbeater.cc:461] Registering TS with master...
14:21:17.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.098831  8706 heartbeater.cc:507] Master 127.7.248.62:38865 requested a full tablet report, sending...
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.098863  8705 heartbeater.cc:344] Connected to a master server at 127.7.248.60:33885
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.098924  8705 heartbeater.cc:461] Registering TS with master...
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099009  8707 heartbeater.cc:344] Connected to a master server at 127.7.248.61:43847
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099021  8705 heartbeater.cc:507] Master 127.7.248.60:33885 requested a full tablet report, sending...
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099063  8707 heartbeater.cc:461] Registering TS with master...
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099180  8707 heartbeater.cc:507] Master 127.7.248.61:43847 requested a full tablet report, sending...
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099251  8202 ts_manager.cc:194] Registered new tserver with Master: 27cfec9ef9ce4d03b2eb445130ca1255 (127.7.248.2:33431)
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099502  8346 ts_manager.cc:194] Registered new tserver with Master: 27cfec9ef9ce4d03b2eb445130ca1255 (127.7.248.2:33431)
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099507  8274 ts_manager.cc:194] Registered new tserver with Master: 27cfec9ef9ce4d03b2eb445130ca1255 (127.7.248.2:33431)
14:21:17.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.099913  8346 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.248.2:42961
14:21:17.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.102944  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8577
14:21:17.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.103017  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-1/wal/instance
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.103981  8160 external_mini_cluster.cc:1372] Running /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task8iUlhY/build/release/bin/kudu
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/logs
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data/info.pb
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.3:0
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.3
14:21:17.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.3
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:17.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:21:17.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.180210  8712 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:21:17.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.180375  8712 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:21:17.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.180393  8712 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:21:17.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.182102  8712 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:21:17.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.182158  8712 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.248.3
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.183574  8712 tablet_server_runner.cc:78] Tablet server non-default flags:
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.248.20:36355
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:21:17.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.248.3:0
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data/info.pb
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.248.3
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.248.62:38865,127.7.248.61:43847,127.7.248.60:33885
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8712
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.248.3
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/logs
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision e5736f718e5e433722f6b8766b4c965bea8722fd
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 13:59:26 UTC on e7f111948823
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16862
14:21:17.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.183751  8712 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:21:17.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.183921  8712 file_cache.cc:504] Constructed file cache file cache with capacity 419430
14:21:17.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.186336  8720 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
14:21:17.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.186343  8717 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
14:21:17.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:17.186344  8718 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
14:21:17.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.186496  8712 server_base.cc:1061] running on GCE node
14:21:17.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.186942  8712 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:21:17.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.187116  8712 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:21:17.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.188230  8712 hybrid_clock.cc:648] HybridClock initialized: now 1783520477188213 us; error 33 us; skew 500 ppm
14:21:17.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.189267  8712 webserver.cc:533] Webserver started at http://127.7.248.3:38749/ using document root <none> and password file <none>
14:21:17.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.189489  8712 fs_manager.cc:362] Metadata directory not provided
14:21:17.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.189553  8712 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:21:17.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.189663  8712 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:21:17.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.190557  8712 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data/instance:
14:21:17.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437785f2d60e442ca6c75c6a483a3519"
14:21:17.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.190907  8712 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal/instance:
14:21:17.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437785f2d60e442ca6c75c6a483a3519"
14:21:17.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.192312  8712 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.193081  8726 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.193287  8712 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.193349  8712 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data,/tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "437785f2d60e442ca6c75c6a483a3519"
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 14:21:17 on dist-test-slave-63nk"
14:21:17.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.193400  8712 fs_report.cc:389] FS layout report
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data/data
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:21:17.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:21:17.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.212462  8712 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.212824  8712 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
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.212953  8712 kserver.cc:163] Server-wide thread pool size limit: 3276
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.213201  8712 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.213589  8712 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.213644  8712 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.213677  8712 ts_tablet_manager.cc:616] Registered 0 tablets
14:21:17.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.213694  8712 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:21:17.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.219696  8712 rpc_server.cc:307] RPC server started. Bound to: 127.7.248.3:40531
14:21:17.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.219792  8839 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.248.3:40531 every 8 connection(s)
14:21:17.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.220155  8712 server_base.cc:1193] Dumped server information to /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/data/info.pb
14:21:17.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.225471  8841 heartbeater.cc:344] Connected to a master server at 127.7.248.62:38865
14:21:17.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.225574  8841 heartbeater.cc:461] Registering TS with master...
14:21:17.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.225716  8841 heartbeater.cc:507] Master 127.7.248.62:38865 requested a full tablet report, sending...
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.225922  8840 heartbeater.cc:344] Connected to a master server at 127.7.248.60:33885
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.225976  8840 heartbeater.cc:461] Registering TS with master...
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226053  8840 heartbeater.cc:507] Master 127.7.248.60:33885 requested a full tablet report, sending...
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226122  8202 ts_manager.cc:194] Registered new tserver with Master: 437785f2d60e442ca6c75c6a483a3519 (127.7.248.3:40531)
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226220  8842 heartbeater.cc:344] Connected to a master server at 127.7.248.61:43847
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226259  8842 heartbeater.cc:461] Registering TS with master...
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226303  8346 ts_manager.cc:194] Registered new tserver with Master: 437785f2d60e442ca6c75c6a483a3519 (127.7.248.3:40531)
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226332  8842 heartbeater.cc:507] Master 127.7.248.61:43847 requested a full tablet report, sending...
14:21:17.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226694  8346 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.248.3:37243
14:21:17.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.226882  8274 ts_manager.cc:194] Registered new tserver with Master: 437785f2d60e442ca6c75c6a483a3519 (127.7.248.3:40531)
14:21:17.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.228312  8160 external_mini_cluster.cc:1434] Started /tmp/dist-test-task8iUlhY/build/release/bin/kudu as pid 8712
14:21:17.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.228377  8160 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task8iUlhY/test-tmp/mini-kudu-cluster2169925416726438313/ts-2/wal/instance
14:21:17.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.230451  8160 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
14:21:17.231 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:21:17.232 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:21:17.241 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.248.62"
      port: 38865
    }
    bound_http_address {
      host: "127.7.248.62"
      port: 34103
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.248.61"
      port: 43847
    }
    bound_http_address {
      host: "127.7.248.61"
      port: 33965
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.248.60"
      port: 33885
    }
    bound_http_address {
      host: "127.7.248.60"
      port: 33525
    }
  }
}

14:21:17.244 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

14:21:17.246 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.248.1"
      port: 45125
    }
    bound_http_address {
      host: "127.7.248.1"
      port: 40159
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.248.2"
      port: 33431
    }
    bound_http_address {
      host: "127.7.248.2"
      port: 36867
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.248.3"
      port: 40531
    }
    bound_http_address {
      host: "127.7.248.3"
      port: 38749
    }
  }
}

14:21:17.246 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:21:17.433 [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)
14:21:17.494 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:21:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.624392  8414 catalog_manager.cc:1295] Loaded cluster ID: 6172eb04d98e461ea150561cbfd88dc3
14:21:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.624470  8414 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: loading cluster ID for follower catalog manager: success
14:21:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.625795  8414 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: acquiring CA information for follower catalog manager: success
14:21:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.626098  8414 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 749af28f55864d5eba3aa958778edb72: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:21:17.641 [DEBUG - main] (Connection.java:748) [peer master-127.7.248.61:43847(127.7.248.61:43847)] connecting to peer
14:21:17.689 [DEBUG - main] (Connection.java:748) [peer master-127.7.248.62:38865(127.7.248.62:38865)] connecting to peer
14:21:17.690 [DEBUG - main] (Connection.java:748) [peer master-127.7.248.60:33885(127.7.248.60:33885)] connecting to peer
14:21:17.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.697788  8428 catalog_manager.cc:1295] Loaded cluster ID: 6172eb04d98e461ea150561cbfd88dc3
14:21:17.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.697866  8428 catalog_manager.cc:1588] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: loading cluster ID for follower catalog manager: success
14:21:17.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.698765  8428 catalog_manager.cc:1610] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: acquiring CA information for follower catalog manager: success
14:21:17.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.698992  8428 catalog_manager.cc:1638] T 00000000000000000000000000000000 P f8fb6730ae2b4384bd92f94cb8ff79ea: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:21:17.708 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.248.62:38865(127.7.248.62:38865)] Successfully connected to peer
14:21:17.708 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.7.248.60:33885(127.7.248.60:33885)] Successfully connected to peer
14:21:17.708 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.248.61:43847(127.7.248.61:43847)] Successfully connected to peer
14:21:17.804 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.248.61
14:21:17.804 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.248.62
14:21:17.812 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.248.60
14:21:17.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:17.990604  8570 heartbeater.cc:499] Master 127.7.248.60:33885 was elected leader, sending a full tablet report...
14:21:18.021 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0x96b3b922, L:/127.0.0.1:55786 - R:/127.7.248.60:33885] using SASL/PLAIN
14:21:18.021 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x53a7e638, L:/127.0.0.1:45922 - R:/127.7.248.61:43847] using SASL/PLAIN
14:21:18.022 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x366e9764, L:/127.0.0.1:40164 - R:/127.7.248.62:38865] using SASL/PLAIN
14:21:18.054 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:21:18.055 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=450), Traces: [0ms] refreshing cache from master, [25ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.248.61:43847, [82ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.248.62:38865, [83ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.248.60:33885, [426ms] Sub RPC ConnectToMaster: received response from server master-127.7.248.61:43847: OK, [427ms] Sub RPC ConnectToMaster: received response from server master-127.7.248.62:38865: OK, [427ms] Sub RPC ConnectToMaster: received response from server master-127.7.248.60:33885: OK, deferred=null) after lookup
14:21:18.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.100495  8705 heartbeater.cc:499] Master 127.7.248.60:33885 was elected leader, sending a full tablet report...
14:21:18.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.107275  8346 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:55786:
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783520475764"
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:21:18.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.107613  8346 catalog_manager.cc:7077] 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-1783520475764 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.117313  8504 tablet_service.cc:1511] Processing CreateTablet for tablet 53d1a52176c04bf2a9b29524e48d0008 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783520475764 [id=d7a4fbf080ad4c8dbee98f5310bd70f9]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.117622  8504 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 53d1a52176c04bf2a9b29524e48d0008. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.117712  8774 tablet_service.cc:1511] Processing CreateTablet for tablet 53d1a52176c04bf2a9b29524e48d0008 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783520475764 [id=d7a4fbf080ad4c8dbee98f5310bd70f9]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.117918  8774 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 53d1a52176c04bf2a9b29524e48d0008. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.120128  8868 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Bootstrap starting.
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.120682  8869 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Bootstrap starting.
14:21:18.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.120869  8868 tablet_bootstrap.cc:654] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Neither blocks nor log segments found. Creating new log.
14:21:18.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.120851  8639 tablet_service.cc:1511] Processing CreateTablet for tablet 53d1a52176c04bf2a9b29524e48d0008 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783520475764 [id=d7a4fbf080ad4c8dbee98f5310bd70f9]), partition=RANGE (key) PARTITION UNBOUNDED
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121124  8639 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 53d1a52176c04bf2a9b29524e48d0008. 1 dirs total, 0 dirs full, 0 dirs failed
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121193  8868 log.cc:826] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Log is configured to *not* fsync() on all Append() calls
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121313  8869 tablet_bootstrap.cc:654] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Neither blocks nor log segments found. Creating new log.
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121628  8869 log.cc:826] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Log is configured to *not* fsync() on all Append() calls
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121848  8868 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: No bootstrap required, opened a new log
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.121905  8868 ts_tablet_manager.cc:1403] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Time spent bootstrapping tablet: real 0.002s	user 0.002s	sys 0.000s
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.122357  8869 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: No bootstrap required, opened a new log
14:21:18.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.122413  8869 ts_tablet_manager.cc:1403] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.123795  8868 raft_consensus.cc:359] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.123951  8868 raft_consensus.cc:385] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.123992  8868 raft_consensus.cc:740] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: abeb7ec520d04c30bd66599f988e29ed, State: Initialized, Role: FOLLOWER
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124117  8872 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: Bootstrap starting.
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124084  8868 consensus_queue.cc:260] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [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: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.123983  8869 raft_consensus.cc:359] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124190  8869 raft_consensus.cc:385] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124226  8869 raft_consensus.cc:740] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 437785f2d60e442ca6c75c6a483a3519, State: Initialized, Role: FOLLOWER
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124310  8868 ts_tablet_manager.cc:1434] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Time spent starting tablet: real 0.002s	user 0.000s	sys 0.002s
14:21:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124301  8869 consensus_queue.cc:260] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [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: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124503  8869 ts_tablet_manager.cc:1434] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
14:21:18.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124750  8872 tablet_bootstrap.cc:654] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: Neither blocks nor log segments found. Creating new log.
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.124789  8840 heartbeater.cc:499] Master 127.7.248.60:33885 was elected leader, sending a full tablet report...
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.125089  8872 log.cc:826] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: Log is configured to *not* fsync() on all Append() calls
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.125643  8872 tablet_bootstrap.cc:492] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: No bootstrap required, opened a new log
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.125698  8872 ts_tablet_manager.cc:1403] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.127562  8872 raft_consensus.cc:359] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.127704  8872 raft_consensus.cc:385] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.127743  8872 raft_consensus.cc:740] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 27cfec9ef9ce4d03b2eb445130ca1255, State: Initialized, Role: FOLLOWER
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.127833  8872 consensus_queue.cc:260] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [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: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.128038  8872 ts_tablet_manager.cc:1434] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
14:21:18.138 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table d7a4fbf080ad4c8dbee98f5310bd70f9
14:21:18.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.146817  8873 raft_consensus.cc:493] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:21:18.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.147073  8873 raft_consensus.cc:515] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.147445  8873 leader_election.cc:290] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 437785f2d60e442ca6c75c6a483a3519 (127.7.248.3:40531), 27cfec9ef9ce4d03b2eb445130ca1255 (127.7.248.2:33431)
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151242  8659 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "53d1a52176c04bf2a9b29524e48d0008" candidate_uuid: "abeb7ec520d04c30bd66599f988e29ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" is_pre_election: true
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151414  8659 raft_consensus.cc:2468] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate abeb7ec520d04c30bd66599f988e29ed in term 0.
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151449  8794 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "53d1a52176c04bf2a9b29524e48d0008" candidate_uuid: "abeb7ec520d04c30bd66599f988e29ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "437785f2d60e442ca6c75c6a483a3519" is_pre_election: true
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151611  8794 raft_consensus.cc:2468] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate abeb7ec520d04c30bd66599f988e29ed in term 0.
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151633  8457 leader_election.cc:304] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [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: 27cfec9ef9ce4d03b2eb445130ca1255, abeb7ec520d04c30bd66599f988e29ed; no voters: 
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151757  8873 raft_consensus.cc:2804] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Leader pre-election won for term 1
14:21:18.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151796  8873 raft_consensus.cc:493] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:21:18.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.151818  8873 raft_consensus.cc:3060] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 0 FOLLOWER]: Advancing to term 1
14:21:18.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.152721  8873 raft_consensus.cc:515] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.152848  8873 leader_election.cc:290] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [CANDIDATE]: Term 1 election: Requested vote from peers 437785f2d60e442ca6c75c6a483a3519 (127.7.248.3:40531), 27cfec9ef9ce4d03b2eb445130ca1255 (127.7.248.2:33431)
14:21:18.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.153024  8659 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "53d1a52176c04bf2a9b29524e48d0008" candidate_uuid: "abeb7ec520d04c30bd66599f988e29ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "27cfec9ef9ce4d03b2eb445130ca1255"
14:21:18.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.153087  8659 raft_consensus.cc:3060] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 0 FOLLOWER]: Advancing to term 1
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.153878  8659 raft_consensus.cc:2468] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate abeb7ec520d04c30bd66599f988e29ed in term 1.
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.153860  8794 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "53d1a52176c04bf2a9b29524e48d0008" candidate_uuid: "abeb7ec520d04c30bd66599f988e29ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "437785f2d60e442ca6c75c6a483a3519"
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.153931  8794 raft_consensus.cc:3060] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 0 FOLLOWER]: Advancing to term 1
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.154034  8457 leader_election.cc:304] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [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: 27cfec9ef9ce4d03b2eb445130ca1255, abeb7ec520d04c30bd66599f988e29ed; no voters: 
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.154107  8873 raft_consensus.cc:2804] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 1 FOLLOWER]: Leader election won for term 1
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.154235  8873 raft_consensus.cc:697] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [term 1 LEADER]: Becoming Leader. State: Replica: abeb7ec520d04c30bd66599f988e29ed, State: Running, Role: LEADER
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.154332  8873 consensus_queue.cc:237] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [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: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } }
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.155066  8794 raft_consensus.cc:2468] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate abeb7ec520d04c30bd66599f988e29ed in term 1.
14:21:18.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.155117  8346 catalog_manager.cc:5697] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed reported cstate change: term changed from 0 to 1, leader changed from <none> to abeb7ec520d04c30bd66599f988e29ed (127.7.248.1). New cstate: current_term: 1 leader_uuid: "abeb7ec520d04c30bd66599f988e29ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "abeb7ec520d04c30bd66599f988e29ed" member_type: VOTER last_known_addr { host: "127.7.248.1" port: 45125 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 } health_report { overall_health: UNKNOWN } } }
14:21:18.191 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 53d1a52176c04bf2a9b29524e48d0008 for table 'org.apache.kudu.client.TestHybridTime-1783520475764' with partition [<start>, <end>)
14:21:18.197 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=53d1a52176c04bf2a9b29524e48d0008@[27cfec9ef9ce4d03b2eb445130ca1255(127.7.248.2:33431),437785f2d60e442ca6c75c6a483a3519(127.7.248.3:40531),abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)[L]]}]
14:21:18.199 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=16), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.248.60:33885, [8ms] Sub RPC GetTableLocations: received response from server master-127.7.248.60:33885: OK, deferred=null) after lookup
14:21:18.208 [DEBUG - kudu-nio-2] (Connection.java:748) [peer abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)] connecting to peer
14:21:18.210 [DEBUG - kudu-nio-3] (Connection.java:757) [peer abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)] Successfully connected to peer
14:21:18.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.221946  8843 tablet.cc:2406] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:18.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 14:21:18.234869  8573 tablet.cc:2406] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:21:18.279 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x1988a449, L:/127.0.0.1:35910 - R:/127.7.248.1:45125] using TOKEN/null
14:21:18.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.282817  8659 raft_consensus.cc:1275] T 53d1a52176c04bf2a9b29524e48d0008 P 27cfec9ef9ce4d03b2eb445130ca1255 [term 1 FOLLOWER]: Refusing update from remote peer abeb7ec520d04c30bd66599f988e29ed: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:21:18.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.283111  8794 raft_consensus.cc:1275] T 53d1a52176c04bf2a9b29524e48d0008 P 437785f2d60e442ca6c75c6a483a3519 [term 1 FOLLOWER]: Refusing update from remote peer abeb7ec520d04c30bd66599f988e29ed: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:21:18.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.283732  8873 consensus_queue.cc:1048] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [LEADER]: Connected to new peer: Peer: permanent_uuid: "437785f2d60e442ca6c75c6a483a3519" member_type: VOTER last_known_addr { host: "127.7.248.3" port: 40531 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:18.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.283854  8879 consensus_queue.cc:1048] T 53d1a52176c04bf2a9b29524e48d0008 P abeb7ec520d04c30bd66599f988e29ed [LEADER]: Connected to new peer: Peer: permanent_uuid: "27cfec9ef9ce4d03b2eb445130ca1255" member_type: VOTER last_known_addr { host: "127.7.248.2" port: 33431 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:21:18.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.287801  8883 mvcc.cc:204] Tried to move back new op lower bound from 7305299879043383296 to 7305299878520578048. Current Snapshot: MvccSnapshot[applied={T|T < 7305299879043383296}]
14:21:18.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.294219  8884 mvcc.cc:204] Tried to move back new op lower bound from 7305299879043383296 to 7305299878520578048. Current Snapshot: MvccSnapshot[applied={T|T < 7305299879043383296}]
14:21:18.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.292541  8885 mvcc.cc:204] Tried to move back new op lower bound from 7305299879043383296 to 7305299878520578048. Current Snapshot: MvccSnapshot[applied={T|T < 7305299879043383296}]
14:21:18.322 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.330 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.335 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.348 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1214008504(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:21:18.356 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.356 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@980736053(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:21:18.360 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.360 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1720194801(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:21:18.363 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:21:18.405 [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-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.410 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305299899523383297) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.414 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305299899523383301) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.416 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305299899523383305) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.419 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305299899523383309) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.422 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305299899523383313) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.424 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305299899523383317) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.427 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305299899523383318) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783520475764, tablet=53d1a52176c04bf2a9b29524e48d0008, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:21:18.430 [DEBUG - main] (Connection.java:575) [peer master-127.7.248.60:33885(127.7.248.60:33885)] disconnecting while in state READY
14:21:18.431 [DEBUG - main] (Connection.java:575) [peer master-127.7.248.62:38865(127.7.248.62:38865)] disconnecting while in state READY
14:21:18.431 [DEBUG - main] (Connection.java:575) [peer master-127.7.248.61:43847(127.7.248.61:43847)] disconnecting while in state READY
14:21:18.431 [DEBUG - main] (Connection.java:575) [peer abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)] disconnecting while in state READY
14:21:18.435 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:21:18.436 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.248.61:43847(127.7.248.61:43847)] handling channelInactive
14:21:18.436 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.248.62:38865(127.7.248.62:38865)] handling channelInactive
14:21:18.436 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.7.248.60:33885(127.7.248.60:33885)] handling channelInactive
14:21:18.437 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.248.61:43847(127.7.248.61:43847)] cleaning up while in state READY due to: connection closed
14:21:18.437 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.248.62:38865(127.7.248.62:38865)] cleaning up while in state READY due to: connection closed
14:21:18.437 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.7.248.60:33885(127.7.248.60:33885)] cleaning up while in state READY due to: connection closed
14:21:18.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.442173  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8442
14:21:18.444 [DEBUG - kudu-nio-3] (Connection.java:239) [peer abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)] handling channelInactive
14:21:18.444 [DEBUG - kudu-nio-3] (Connection.java:709) [peer abeb7ec520d04c30bd66599f988e29ed(127.7.248.1:45125)] cleaning up while in state READY due to: connection closed
14:21:18.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.450214  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8577
14:21:18.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.456954  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8712
14:21:18.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.463410  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8171
14:21:18.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.470959  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8242
14:21:18.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 14:21:18.477497  8160 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task8iUlhY/build/release/bin/kudu with pid 8312
14:21:18.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T14:21:18Z chronyd exiting

Time: 2.678

OK (1 test)

