JUnit version 4.13.2
.23:08:01.962 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783465681953
23:08:01.989 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
23:08:02.023 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
23:08:02.030 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskCqdbEn/test-tmp
23:08:02.054 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
23:08:02.057 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskCqdbEn/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
23:08:02.271 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

23:08:02.288 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:08:02.289 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

23:08:02.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.291498 21673 mini_oidc.cc:150] Starting JWKS server
23:08:02.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.293684 21673 webserver.cc:534] Webserver started at http://127.0.0.1:42271/ using document root <none> and password file <none>
23:08:02.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.293870 21673 mini_oidc.cc:186] Starting OIDC Discovery server
23:08:02.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.294121 21673 webserver.cc:534] Webserver started at http://127.0.0.1:36295/ using document root <none> and password file <none>
23:08:02.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:08:02Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
23:08:02.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:08:02Z Disabled control of system clock
23:08:02.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.314445 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal
23:08:02.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data
23:08:02.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:02.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:02.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:02.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/logs
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data/info.pb
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.126:39809
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.126
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json with env {}
23:08:02.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.418040 21684 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:02.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.418233 21684 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:02.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.418278 21684 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:02.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421674 21684 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:08:02.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421726 21684 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:02.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421754 21684 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:08:02.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421772 21684 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:08:02.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421790 21684 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:08:02.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.421805 21684 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42271/jwks.json
23:08:02.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.425726 21684 master_runner.cc:387] Master server non-default flags:
23:08:02.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.126:39809
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data/info.pb
23:08:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.126
23:08:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21684
23:08:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/logs
23:08:02.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:02.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:02.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:08:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.426841 21684 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.427917 21684 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.433529 21692 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
23:08:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.433698 21684 server_base.cc:1061] running on GCE node
23:08:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.433877 21689 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
23:08:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.434435 21690 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
23:08:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.434881 21684 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:02.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.435936 21684 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:02.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.437090 21684 hybrid_clock.cc:648] HybridClock initialized: now 1783465682437075 us; error 34 us; skew 500 ppm
23:08:02.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.438581 21684 webserver.cc:534] Webserver started at http://127.21.42.126:41441/ using document root <none> and password file <none>
23:08:02.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.439100 21684 fs_manager.cc:362] Metadata directory not provided
23:08:02.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.439149 21684 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:02.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.439294 21684 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.440796 21684 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data/instance:
23:08:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e8fcbdb70ab1430fb6de1037912b83c6"
23:08:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.441193 21684 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal/instance:
23:08:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e8fcbdb70ab1430fb6de1037912b83c6"
23:08:02.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.444340 21684 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
23:08:02.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.446303 21698 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:02.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.447185 21684 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
23:08:02.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.447300 21684 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal
23:08:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e8fcbdb70ab1430fb6de1037912b83c6"
23:08:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.447384 21684 fs_report.cc:389] FS layout report
23:08:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal
23:08:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal
23:08:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data/data
23:08:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:02.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:02.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:02.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.462391 21684 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:02.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.463094 21684 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:02.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.463279 21684 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:02.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.470188 21750 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.126:39809 every 8 connection(s)
23:08:02.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.470189 21684 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.126:39809
23:08:02.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.471271 21684 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/data/info.pb
23:08:02.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.474095 21751 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:02.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.474421 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 21684
23:08:02.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.474577 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-0/wal/instance
23:08:02.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.475991 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal
23:08:02.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/logs
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data/info.pb
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.125:37859
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.125
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json with env {}
23:08:02.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.477476 21751 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.491748 21751 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.492535 21702 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.21.42.125:37859: connect: Connection refused (error 111)
23:08:02.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.493420 21751 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.125:37859: Network error: Client connection negotiation failed: client connection to 127.21.42.125:37859: connect: Connection refused (error 111)
23:08:02.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.542706 21751 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } attempt: 1
23:08:02.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.544298 21751 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.125:37859: Network error: Client connection negotiation failed: client connection to 127.21.42.125:37859: connect: Connection refused (error 111)
23:08:02.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.578879 21753 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:02.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.579056 21753 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:02.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.579097 21753 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:02.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582508 21753 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:08:02.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582561 21753 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:02.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582582 21753 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:08:02.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582600 21753 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:08:02.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582617 21753 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:08:02.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.582633 21753 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42271/jwks.json
23:08:02.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.587431 21753 master_runner.cc:387] Master server non-default flags:
23:08:02.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal
23:08:02.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.125:37859
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data/info.pb
23:08:02.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.125
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21753
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:02.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/logs
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:02.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:02.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.588532 21753 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:02.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.589812 21753 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:02.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.595498 21761 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
23:08:02.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.595614 21764 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
23:08:02.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.595520 21762 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
23:08:02.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.596122 21753 server_base.cc:1061] running on GCE node
23:08:02.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.596642 21753 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:02.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.597530 21753 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:02.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.598683 21753 hybrid_clock.cc:648] HybridClock initialized: now 1783465682598636 us; error 68 us; skew 500 ppm
23:08:02.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.600427 21753 webserver.cc:534] Webserver started at http://127.21.42.125:38905/ using document root <none> and password file <none>
23:08:02.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.600998 21753 fs_manager.cc:362] Metadata directory not provided
23:08:02.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.601078 21753 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:02.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.601286 21753 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:02.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.602861 21753 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data/instance:
23:08:02.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe180752657649d183f85f600c10e5df"
23:08:02.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.603364 21753 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal/instance:
23:08:02.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe180752657649d183f85f600c10e5df"
23:08:02.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.606762 21753 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
23:08:02.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.608870 21770 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:02.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.609952 21753 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
23:08:02.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.610064 21753 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal
23:08:02.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fe180752657649d183f85f600c10e5df"
23:08:02.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.610158 21753 fs_report.cc:389] FS layout report
23:08:02.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:02.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal
23:08:02.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal
23:08:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data/data
23:08:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:02.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:02.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.612473 21751 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } attempt: 2
23:08:02.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.613955 21751 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.125:37859: Network error: Client connection negotiation failed: client connection to 127.21.42.125:37859: connect: Connection refused (error 111)
23:08:02.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.641016 21753 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:02.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.641796 21753 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:02.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.641988 21753 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:02.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.649296 21822 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.125:37859 every 8 connection(s)
23:08:02.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.649303 21753 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.125:37859
23:08:02.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.650413 21753 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/data/info.pb
23:08:02.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.653162 21823 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:02.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.655129 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 21753
23:08:02.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.655231 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-1/wal/instance
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.655970 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/logs
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data/info.pb
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:02.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:08:02.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:02.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.124:42667
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.124
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json with env {}
23:08:02.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.656286 21823 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.667615 21823 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.674850 21823 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.675665 21774 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.676728 21823 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.124:42667: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.705116 21751 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } attempt: 3
23:08:02.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.709621 21751 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.710938 21751 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.124:42667: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.725939 21823 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } attempt: 1
23:08:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.727458 21823 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.124:42667: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.742187 21751 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } attempt: 1
23:08:02.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.743733 21751 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.124:42667: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.763758 21825 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:02.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.764007 21825 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:02.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.764050 21825 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767161 21825 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767207 21825 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767226 21825 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767243 21825 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767261 21825 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:08:02.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.767275 21825 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42271/jwks.json
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.771142 21825 master_runner.cc:387] Master server non-default flags:
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal
23:08:02.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.124:42667
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:08:02.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42271/jwks.json
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data/info.pb
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.124
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:02.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21825
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/logs
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:02.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.772135 21825 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:02.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.773088 21825 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:02.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.778913 21834 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
23:08:02.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.778940 21833 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
23:08:02.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.778968 21836 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
23:08:02.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.779207 21825 server_base.cc:1061] running on GCE node
23:08:02.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.780319 21825 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:02.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.781298 21825 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:02.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.782452 21825 hybrid_clock.cc:648] HybridClock initialized: now 1783465682782407 us; error 61 us; skew 500 ppm
23:08:02.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.784066 21825 webserver.cc:534] Webserver started at http://127.21.42.124:39813/ using document root <none> and password file <none>
23:08:02.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.784683 21825 fs_manager.cc:362] Metadata directory not provided
23:08:02.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.784758 21825 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:02.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.784986 21825 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:02.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.786684 21825 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data/instance:
23:08:02.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bb4c6109f4c64c39ab7986980d996154"
23:08:02.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.787132 21825 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal/instance:
23:08:02.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bb4c6109f4c64c39ab7986980d996154"
23:08:02.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.790248 21825 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.004s
23:08:02.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.792264 21842 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:02.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.793140 21825 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
23:08:02.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.793251 21825 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal
23:08:02.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bb4c6109f4c64c39ab7986980d996154"
23:08:02.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:02 on dist-test-slave-hdrm"
23:08:02.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.793336 21825 fs_report.cc:389] FS layout report
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data/data
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:02.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:02.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.795616 21823 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } attempt: 2
23:08:02.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.796830 21823 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.21.42.124:42667: Network error: Client connection negotiation failed: client connection to 127.21.42.124:42667: connect: Connection refused (error 111)
23:08:02.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.809048 21825 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:02.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.809927 21825 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:02.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.810055 21825 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.816752 21894 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.124:42667 every 8 connection(s)
23:08:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.816756 21825 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.124:42667
23:08:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.817687 21825 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/data/info.pb
23:08:02.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.818907 21751 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } attempt: 2
23:08:02.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.821496 21895 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:02.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.821686 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 21825
23:08:02.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.821776 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/master-2/wal/instance
23:08:02.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.825487 21895 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.832145 21751 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: Bootstrap starting.
23:08:02.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.832459 21895 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.834721 21751 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: Neither blocks nor log segments found. Creating new log.
23:08:02.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.835734 21751 log.cc:826] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: Log is configured to *not* fsync() on all Append() calls
23:08:02.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.837654 21751 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: No bootstrap required, opened a new log
23:08:02.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.839447 21895 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } has no permanent_uuid. Determining permanent_uuid...
23:08:02.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.840911 21751 raft_consensus.cc:359] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.841051 21751 raft_consensus.cc:385] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:02.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.841092 21751 raft_consensus.cc:740] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e8fcbdb70ab1430fb6de1037912b83c6, State: Initialized, Role: FOLLOWER
23:08:02.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.841473 21751 consensus_queue.cc:260] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.842097 21904 sys_catalog.cc:455] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:02.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.842206 21904 sys_catalog.cc:458] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: This master's current role is: FOLLOWER
23:08:02.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.842592 21751 sys_catalog.cc:565] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: configured and running, proceeding with master startup.
23:08:02.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.845016 21895 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: Bootstrap starting.
23:08:02.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.847297 21895 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: Neither blocks nor log segments found. Creating new log.
23:08:02.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.848260 21895 log.cc:826] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: Log is configured to *not* fsync() on all Append() calls
23:08:02.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.850099 21895 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: No bootstrap required, opened a new log
23:08:02.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.848212 21915 catalog_manager.cc:1593] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:08:02.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.850500 21915 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.853767 21895 raft_consensus.cc:359] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.853981 21895 raft_consensus.cc:385] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.854043 21895 raft_consensus.cc:740] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bb4c6109f4c64c39ab7986980d996154, State: Initialized, Role: FOLLOWER
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.851734 21684 master_runner.cc:187] Error getting master registration for 127.21.42.125:37859: OK, instance_id { permanent_uuid: "fe180752657649d183f85f600c10e5df" instance_seqno: 1783465682647433 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.854475 21684 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:08:02.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.854508 21895 consensus_queue.cc:260] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.855592 21895 sys_catalog.cc:565] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: configured and running, proceeding with master startup.
23:08:02.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.856144 21918 sys_catalog.cc:455] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:02.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.860572 21918 sys_catalog.cc:458] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: This master's current role is: FOLLOWER
23:08:02.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.862869 21929 catalog_manager.cc:1593] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:08:02.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.863202 21929 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:08:02.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.863844 21825 master_runner.cc:187] Error getting master registration for 127.21.42.125:37859: OK, instance_id { permanent_uuid: "fe180752657649d183f85f600c10e5df" instance_seqno: 1783465682647433 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
23:08:02.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.865396 21825 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:08:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.888008 21823 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } attempt: 3
23:08:02.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.894359 21823 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: Bootstrap starting.
23:08:02.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.896569 21823 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: Neither blocks nor log segments found. Creating new log.
23:08:02.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.897326 21823 log.cc:826] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: Log is configured to *not* fsync() on all Append() calls
23:08:02.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.899076 21823 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: No bootstrap required, opened a new log
23:08:02.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.902084 21823 raft_consensus.cc:359] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.902520 21823 raft_consensus.cc:385] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:02.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.902797 21823 raft_consensus.cc:740] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fe180752657649d183f85f600c10e5df, State: Initialized, Role: FOLLOWER
23:08:02.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.903436 21823 consensus_queue.cc:260] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:02.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.903980 21932 sys_catalog.cc:455] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:02.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.904305 21932 sys_catalog.cc:458] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: This master's current role is: FOLLOWER
23:08:02.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.904654 21823 sys_catalog.cc:565] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: configured and running, proceeding with master startup.
23:08:02.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.909658 21943 catalog_manager.cc:1593] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
23:08:02.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.909955 21943 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
23:08:02.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.912729 21753 master_runner.cc:264] No leader master found from master fe180752657649d183f85f600c10e5df
23:08:02.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:02.912788 21753 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
23:08:02.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:02.964686 21704 tablet.cc:2406] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:08:03.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.010300 21904 raft_consensus.cc:493] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:08:03.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.010478 21904 raft_consensus.cc:515] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:03.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.011531 21904 leader_election.cc:290] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers fe180752657649d183f85f600c10e5df (127.21.42.125:37859), bb4c6109f4c64c39ab7986980d996154 (127.21.42.124:42667)
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.012179 21797 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fe180752657649d183f85f600c10e5df" is_pre_election: true
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.012451 21797 raft_consensus.cc:2468] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e8fcbdb70ab1430fb6de1037912b83c6 in term 0.
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.012933 21702 leader_election.cc:304] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [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: e8fcbdb70ab1430fb6de1037912b83c6, fe180752657649d183f85f600c10e5df; no voters: 
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.013465 21869 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bb4c6109f4c64c39ab7986980d996154" is_pre_election: true
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.013711 21869 raft_consensus.cc:2468] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e8fcbdb70ab1430fb6de1037912b83c6 in term 0.
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.014226 21904 raft_consensus.cc:2804] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Leader pre-election won for term 1
23:08:03.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.014289 21904 raft_consensus.cc:493] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.014329 21904 raft_consensus.cc:3060] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 0 FOLLOWER]: Advancing to term 1
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.015342 21904 raft_consensus.cc:515] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.015661 21904 leader_election.cc:290] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [CANDIDATE]: Term 1 election: Requested vote from peers fe180752657649d183f85f600c10e5df (127.21.42.125:37859), bb4c6109f4c64c39ab7986980d996154 (127.21.42.124:42667)
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.016149 21797 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fe180752657649d183f85f600c10e5df"
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.016258 21797 raft_consensus.cc:3060] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 0 FOLLOWER]: Advancing to term 1
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.017233 21797 raft_consensus.cc:2468] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e8fcbdb70ab1430fb6de1037912b83c6 in term 1.
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.017974 21869 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bb4c6109f4c64c39ab7986980d996154"
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.018070 21869 raft_consensus.cc:3060] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 0 FOLLOWER]: Advancing to term 1
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.018998 21869 raft_consensus.cc:2468] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e8fcbdb70ab1430fb6de1037912b83c6 in term 1.
23:08:03.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.019187 21702 leader_election.cc:304] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [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: e8fcbdb70ab1430fb6de1037912b83c6, fe180752657649d183f85f600c10e5df; no voters: 
23:08:03.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.022011 21904 raft_consensus.cc:2804] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 1 FOLLOWER]: Leader election won for term 1
23:08:03.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.022197 21904 raft_consensus.cc:697] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [term 1 LEADER]: Becoming Leader. State: Replica: e8fcbdb70ab1430fb6de1037912b83c6, State: Running, Role: LEADER
23:08:03.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.022506 21904 consensus_queue.cc:237] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [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: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } }
23:08:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.029671 21904 sys_catalog.cc:455] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: SysCatalogTable state changed. Reason: New leader e8fcbdb70ab1430fb6de1037912b83c6. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.029771 21904 sys_catalog.cc:458] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: This master's current role is: LEADER
23:08:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.044180 21947 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
23:08:03.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.045511 21947 catalog_manager.cc:1519] Initializing Kudu cluster ID...
23:08:03.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.057504 21869 raft_consensus.cc:1275] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [term 1 FOLLOWER]: Refusing update from remote peer e8fcbdb70ab1430fb6de1037912b83c6: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:08:03.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.059293 21945 consensus_queue.cc:1048] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [LEADER]: Connected to new peer: Peer: permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:08:03.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.063061 21918 sys_catalog.cc:455] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: SysCatalogTable state changed. Reason: New leader e8fcbdb70ab1430fb6de1037912b83c6. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.063164 21918 sys_catalog.cc:458] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: This master's current role is: FOLLOWER
23:08:03.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.063306 21848 tablet.cc:2406] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:08:03.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.069855 21797 raft_consensus.cc:1275] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [term 1 FOLLOWER]: Refusing update from remote peer e8fcbdb70ab1430fb6de1037912b83c6: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:08:03.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.070439 21945 consensus_queue.cc:1048] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [LEADER]: Connected to new peer: Peer: permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:08:03.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.074581 21932 sys_catalog.cc:455] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: SysCatalogTable state changed. Reason: New leader e8fcbdb70ab1430fb6de1037912b83c6. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.074687 21932 sys_catalog.cc:458] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: This master's current role is: FOLLOWER
23:08:03.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.085173 21945 sys_catalog.cc:455] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.085289 21945 sys_catalog.cc:458] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: This master's current role is: LEADER
23:08:03.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.086777 21932 sys_catalog.cc:455] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.086874 21932 sys_catalog.cc:458] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df [sys.catalog]: This master's current role is: FOLLOWER
23:08:03.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.087502 21948 mvcc.cc:204] Tried to move back new op lower bound from 7305075437794938880 to 7305075437685805056. Current Snapshot: MvccSnapshot[applied={T|T < 7305075437794938880}]
23:08:03.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.088449 21904 sys_catalog.cc:455] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.088553 21904 sys_catalog.cc:458] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6 [sys.catalog]: This master's current role is: LEADER
23:08:03.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.089762 21918 sys_catalog.cc:455] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e8fcbdb70ab1430fb6de1037912b83c6" member_type: VOTER last_known_addr { host: "127.21.42.126" port: 39809 } } peers { permanent_uuid: "fe180752657649d183f85f600c10e5df" member_type: VOTER last_known_addr { host: "127.21.42.125" port: 37859 } } peers { permanent_uuid: "bb4c6109f4c64c39ab7986980d996154" member_type: VOTER last_known_addr { host: "127.21.42.124" port: 42667 } } }
23:08:03.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.089859 21918 sys_catalog.cc:458] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154 [sys.catalog]: This master's current role is: FOLLOWER
23:08:03.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.090786 21951 mvcc.cc:204] Tried to move back new op lower bound from 7305075437794938880 to 7305075437685805056. Current Snapshot: MvccSnapshot[applied={T|T < 7305075437794938880}]
23:08:03.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.091156 21949 mvcc.cc:204] Tried to move back new op lower bound from 7305075437794938880 to 7305075437685805056. Current Snapshot: MvccSnapshot[applied={T|T < 7305075437794938880}]
23:08:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.097541 21947 catalog_manager.cc:1382] Generated new cluster ID: 66211183b5124fdc9d4ea3a0b5c98bb2
23:08:03.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.097613 21947 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
23:08:03.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.120044 21947 catalog_manager.cc:1405] Generated new certificate authority record
23:08:03.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.120991 21947 catalog_manager.cc:1539] Loading token signing keys...
23:08:03.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.128561 21947 catalog_manager.cc:6069] T 00000000000000000000000000000000 P e8fcbdb70ab1430fb6de1037912b83c6: Generated new TSK 0
23:08:03.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.129586 21947 catalog_manager.cc:1549] Initializing in-progress tserver states...
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.153128 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:03.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/logs
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data/info.pb
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:03.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.65:0
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.65
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.65
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:08:03.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.253715 21956 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:03.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.253898 21956 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:03.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.253937 21956 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:03.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.257124 21956 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:03.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.257230 21956 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.42.65
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.260986 21956 tablet_server_runner.cc:78] Tablet server non-default flags:
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.65:0
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data/info.pb
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.65
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21956
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.65
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/logs
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:03.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:03.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:03.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:03.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.261986 21956 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:03.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.263337 21956 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:03.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.270696 21961 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
23:08:03.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.270730 21962 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
23:08:03.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.270694 21964 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
23:08:03.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.271528 21956 server_base.cc:1061] running on GCE node
23:08:03.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.271924 21956 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:03.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.272548 21956 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:03.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.273721 21956 hybrid_clock.cc:648] HybridClock initialized: now 1783465683273693 us; error 44 us; skew 500 ppm
23:08:03.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.275615 21956 webserver.cc:534] Webserver started at http://127.21.42.65:41517/ using document root <none> and password file <none>
23:08:03.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.276248 21956 fs_manager.cc:362] Metadata directory not provided
23:08:03.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.276329 21956 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:03.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.276522 21956 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:03.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.278410 21956 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data/instance:
23:08:03.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93df6ba09b8d48418d6140ee97f5a868"
23:08:03.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.278934 21956 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal/instance:
23:08:03.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93df6ba09b8d48418d6140ee97f5a868"
23:08:03.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.282814 21956 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
23:08:03.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.285156 21970 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.286053 21956 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.286137 21956 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "93df6ba09b8d48418d6140ee97f5a868"
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.286196 21956 fs_report.cc:389] FS layout report
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data/data
23:08:03.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:03.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:03.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.303581 21956 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:03.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.304334 21956 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:03.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.304526 21956 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:03.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.305203 21956 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:08:03.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.306496 21956 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:08:03.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.306587 21956 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:08:03.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.306643 21956 ts_tablet_manager.cc:616] Registered 0 tablets
23:08:03.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.306666 21956 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:08:03.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.315884 21956 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.65:40071
23:08:03.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.315934 22083 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.65:40071 every 8 connection(s)
23:08:03.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.316787 21956 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/data/info.pb
23:08:03.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.318405 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 21956
23:08:03.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.318511 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-0/wal/instance
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.321908 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/logs
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data/info.pb
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.66:0
23:08:03.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.66
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.66
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.326941 22085 heartbeater.cc:344] Connected to a master server at 127.21.42.124:42667
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.326992 22086 heartbeater.cc:344] Connected to a master server at 127.21.42.125:37859
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327168 22085 heartbeater.cc:461] Registering TS with master...
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327169 22086 heartbeater.cc:461] Registering TS with master...
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327502 22084 heartbeater.cc:344] Connected to a master server at 127.21.42.126:39809
23:08:03.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327713 22084 heartbeater.cc:461] Registering TS with master...
23:08:03.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327768 22086 heartbeater.cc:507] Master 127.21.42.125:37859 requested a full tablet report, sending...
23:08:03.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.327775 22085 heartbeater.cc:507] Master 127.21.42.124:42667 requested a full tablet report, sending...
23:08:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.328115 22084 heartbeater.cc:507] Master 127.21.42.126:39809 requested a full tablet report, sending...
23:08:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.329543 21787 ts_manager.cc:194] Registered new tserver with Master: 93df6ba09b8d48418d6140ee97f5a868 (127.21.42.65:40071)
23:08:03.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.329543 21859 ts_manager.cc:194] Registered new tserver with Master: 93df6ba09b8d48418d6140ee97f5a868 (127.21.42.65:40071)
23:08:03.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.330732 21714 ts_manager.cc:194] Registered new tserver with Master: 93df6ba09b8d48418d6140ee97f5a868 (127.21.42.65:40071)
23:08:03.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.331763 21714 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.21.42.65:39779
23:08:03.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.427536 22091 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:03.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.427752 22091 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:03.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.427806 22091 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:03.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.431087 22091 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:03.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.431224 22091 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.42.66
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.435099 22091 tablet_server_runner.cc:78] Tablet server non-default flags:
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.66:0
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:03.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data/info.pb
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.66
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22091
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.66
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/logs
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:03.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:03.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:03.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:03.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:03.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.436434 22091 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:03.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.437706 22091 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:03.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.443527 22096 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
23:08:03.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.443557 22099 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
23:08:03.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.443529 22097 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
23:08:03.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.443933 22091 server_base.cc:1061] running on GCE node
23:08:03.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.444276 22091 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:03.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.444729 22091 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:03.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.445883 22091 hybrid_clock.cc:648] HybridClock initialized: now 1783465683445865 us; error 31 us; skew 500 ppm
23:08:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.447436 22091 webserver.cc:534] Webserver started at http://127.21.42.66:38063/ using document root <none> and password file <none>
23:08:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.448011 22091 fs_manager.cc:362] Metadata directory not provided
23:08:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.448086 22091 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.448311 22091 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.449748 22091 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data/instance:
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd7d7418139b4af38d0bc639e219aa88"
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.450235 22091 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal/instance:
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd7d7418139b4af38d0bc639e219aa88"
23:08:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.453332 22091 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
23:08:03.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.455225 22105 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:03.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.456146 22091 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
23:08:03.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.456251 22091 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal
23:08:03.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bd7d7418139b4af38d0bc639e219aa88"
23:08:03.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.456346 22091 fs_report.cc:389] FS layout report
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data/data
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:03.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:03.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:03.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.484829 22091 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:03.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.485503 22091 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:03.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.485692 22091 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:03.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.486296 22091 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:08:03.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.487228 22091 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:08:03.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.487301 22091 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:08:03.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.487352 22091 ts_tablet_manager.cc:616] Registered 0 tablets
23:08:03.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.487375 22091 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:08:03.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.496452 22091 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.66:34421
23:08:03.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.496480 22218 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.66:34421 every 8 connection(s)
23:08:03.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.497368 22091 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/data/info.pb
23:08:03.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.500308 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 22091
23:08:03.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.500412 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-1/wal/instance
23:08:03.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.502766 21673 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu
23:08:03.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal
23:08:03.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/logs
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data/info.pb
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.67:0
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.67
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.67
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
23:08:03.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.506942 22220 heartbeater.cc:344] Connected to a master server at 127.21.42.124:42667
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.507157 22220 heartbeater.cc:461] Registering TS with master...
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.507648 22220 heartbeater.cc:507] Master 127.21.42.124:42667 requested a full tablet report, sending...
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508165 22219 heartbeater.cc:344] Connected to a master server at 127.21.42.126:39809
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508245 22219 heartbeater.cc:461] Registering TS with master...
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508419 22219 heartbeater.cc:507] Master 127.21.42.126:39809 requested a full tablet report, sending...
23:08:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508721 21859 ts_manager.cc:194] Registered new tserver with Master: bd7d7418139b4af38d0bc639e219aa88 (127.21.42.66:34421)
23:08:03.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508904 22221 heartbeater.cc:344] Connected to a master server at 127.21.42.125:37859
23:08:03.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.508977 22221 heartbeater.cc:461] Registering TS with master...
23:08:03.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.509092 21714 ts_manager.cc:194] Registered new tserver with Master: bd7d7418139b4af38d0bc639e219aa88 (127.21.42.66:34421)
23:08:03.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.509150 22221 heartbeater.cc:507] Master 127.21.42.125:37859 requested a full tablet report, sending...
23:08:03.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.509812 21714 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.21.42.66:44305
23:08:03.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.510867 21787 ts_manager.cc:194] Registered new tserver with Master: bd7d7418139b4af38d0bc639e219aa88 (127.21.42.66:34421)
23:08:03.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.607107 22226 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:08:03.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.607291 22226 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:08:03.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.607329 22226 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:08:03.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.610432 22226 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:08:03.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.610522 22226 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.42.67
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.614117 22226 tablet_server_runner.cc:78] Tablet server non-default flags:
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.42.84:40399
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.42.67:0
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data/info.pb
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.42.67
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.42.126:39809,127.21.42.125:37859,127.21.42.124:42667
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22226
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.42.67
23:08:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/logs
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:23 UTC on bdcb31816ec0
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16826
23:08:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.615058 22226 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:08:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.616073 22226 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:08:03.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.622334 22231 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
23:08:03.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.622335 22232 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
23:08:03.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:03.622368 22234 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
23:08:03.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.622929 22226 server_base.cc:1061] running on GCE node
23:08:03.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.623224 22226 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:08:03.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.623711 22226 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:08:03.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.624898 22226 hybrid_clock.cc:648] HybridClock initialized: now 1783465683624883 us; error 36 us; skew 500 ppm
23:08:03.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.626504 22226 webserver.cc:534] Webserver started at http://127.21.42.67:41141/ using document root <none> and password file <none>
23:08:03.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.627033 22226 fs_manager.cc:362] Metadata directory not provided
23:08:03.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.627084 22226 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:08:03.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.627228 22226 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.628818 22226 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data/instance:
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813c8b4bfdd34d44b56f7e719207415f"
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.629349 22226 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal/instance:
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813c8b4bfdd34d44b56f7e719207415f"
23:08:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.633435 22226 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.004s
23:08:03.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.635947 22240 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.637112 22226 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.637224 22226 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data,/tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813c8b4bfdd34d44b56f7e719207415f"
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:08:03 on dist-test-slave-hdrm"
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.637306 22226 fs_report.cc:389] FS layout report
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data/data
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:08:03.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:08:03.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.669781 22226 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:08:03.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.670842 22226 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:08:03.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.670990 22226 kserver.cc:163] Server-wide thread pool size limit: 3276
23:08:03.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.671448 22226 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:08:03.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.672482 22226 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:08:03.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.672528 22226 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:08:03.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.672566 22226 ts_tablet_manager.cc:616] Registered 0 tablets
23:08:03.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.672581 22226 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:08:03.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.681675 22226 rpc_server.cc:307] RPC server started. Bound to: 127.21.42.67:44813
23:08:03.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.681703 22353 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.21.42.67:44813 every 8 connection(s)
23:08:03.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.682796 22226 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/data/info.pb
23:08:03.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.691146 22354 heartbeater.cc:344] Connected to a master server at 127.21.42.126:39809
23:08:03.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.691362 22354 heartbeater.cc:461] Registering TS with master...
23:08:03.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.691779 22354 heartbeater.cc:507] Master 127.21.42.126:39809 requested a full tablet report, sending...
23:08:03.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692123 22355 heartbeater.cc:344] Connected to a master server at 127.21.42.124:42667
23:08:03.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692373 22355 heartbeater.cc:461] Registering TS with master...
23:08:03.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692500 21673 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu as pid 22226
23:08:03.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692610 21673 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCqdbEn/test-tmp/mini-kudu-cluster11704753000228900089/ts-2/wal/instance
23:08:03.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692708 22355 heartbeater.cc:507] Master 127.21.42.124:42667 requested a full tablet report, sending...
23:08:03.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.692380 22356 heartbeater.cc:344] Connected to a master server at 127.21.42.125:37859
23:08:03.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.693322 22356 heartbeater.cc:461] Registering TS with master...
23:08:03.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.693498 21859 ts_manager.cc:194] Registered new tserver with Master: 813c8b4bfdd34d44b56f7e719207415f (127.21.42.67:44813)
23:08:03.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.693614 22356 heartbeater.cc:507] Master 127.21.42.125:37859 requested a full tablet report, sending...
23:08:03.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.694110 21714 ts_manager.cc:194] Registered new tserver with Master: 813c8b4bfdd34d44b56f7e719207415f (127.21.42.67:44813)
23:08:03.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.694399 21787 ts_manager.cc:194] Registered new tserver with Master: 813c8b4bfdd34d44b56f7e719207415f (127.21.42.67:44813)
23:08:03.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.694751 21714 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.21.42.67:55415
23:08:03.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.698858 21673 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
23:08:03.699 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:08:03.701 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

23:08:03.709 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.42.126"
      port: 39809
    }
    bound_http_address {
      host: "127.21.42.126"
      port: 41441
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.42.125"
      port: 37859
    }
    bound_http_address {
      host: "127.21.42.125"
      port: 38905
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.42.124"
      port: 42667
    }
    bound_http_address {
      host: "127.21.42.124"
      port: 39813
    }
  }
}

23:08:03.712 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

23:08:03.715 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.42.65"
      port: 40071
    }
    bound_http_address {
      host: "127.21.42.65"
      port: 41517
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.42.66"
      port: 34421
    }
    bound_http_address {
      host: "127.21.42.66"
      port: 38063
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.42.67"
      port: 44813
    }
    bound_http_address {
      host: "127.21.42.67"
      port: 41141
    }
  }
}

23:08:03.715 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
23:08:03.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.864878 21929 catalog_manager.cc:1294] Loaded cluster ID: 66211183b5124fdc9d4ea3a0b5c98bb2
23:08:03.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.864981 21929 catalog_manager.cc:1587] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: loading cluster ID for follower catalog manager: success
23:08:03.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.867340 21929 catalog_manager.cc:1609] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: acquiring CA information for follower catalog manager: success
23:08:03.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.868728 21929 catalog_manager.cc:1637] T 00000000000000000000000000000000 P bb4c6109f4c64c39ab7986980d996154: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:08:03.875 [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)
23:08:03.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.911726 21943 catalog_manager.cc:1294] Loaded cluster ID: 66211183b5124fdc9d4ea3a0b5c98bb2
23:08:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.911827 21943 catalog_manager.cc:1587] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: loading cluster ID for follower catalog manager: success
23:08:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.914287 21943 catalog_manager.cc:1609] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: acquiring CA information for follower catalog manager: success
23:08:03.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:03.915766 21943 catalog_manager.cc:1637] T 00000000000000000000000000000000 P fe180752657649d183f85f600c10e5df: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
23:08:03.925 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
23:08:04.058 [DEBUG - main] (Connection.java:748) [peer master-127.21.42.124:42667(127.21.42.124:42667)] connecting to peer
23:08:04.104 [DEBUG - main] (Connection.java:748) [peer master-127.21.42.126:39809(127.21.42.126:39809)] connecting to peer
23:08:04.105 [DEBUG - main] (Connection.java:748) [peer master-127.21.42.125:37859(127.21.42.125:37859)] connecting to peer
23:08:04.123 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.21.42.125:37859(127.21.42.125:37859)] Successfully connected to peer
23:08:04.123 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.21.42.126:39809(127.21.42.126:39809)] Successfully connected to peer
23:08:04.123 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.21.42.124:42667(127.21.42.124:42667)] Successfully connected to peer
23:08:04.212 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.42.124
23:08:04.212 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.42.126
23:08:04.212 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.21.42.125
23:08:04.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.333264 22084 heartbeater.cc:499] Master 127.21.42.126:39809 was elected leader, sending a full tablet report...
23:08:04.412 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x25e84776, L:/127.0.0.1:41100 - R:/127.21.42.125:37859] using SASL/PLAIN
23:08:04.413 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xeb20d2a0, L:/127.0.0.1:58070 - R:/127.21.42.124:42667] using SASL/PLAIN
23:08:04.416 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x0ac53a50, L:/127.0.0.1:53796 - R:/127.21.42.126:39809] using SASL/PLAIN
23:08:04.444 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
23:08:04.445 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=421), Traces: [0ms] refreshing cache from master, [21ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.42.124:42667, [75ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.42.126:39809, [77ms] Sub RPC ConnectToMaster: sending RPC to server master-127.21.42.125:37859, [396ms] Sub RPC ConnectToMaster: received response from server master-127.21.42.125:37859: OK, [396ms] Sub RPC ConnectToMaster: received response from server master-127.21.42.124:42667: OK, [397ms] Sub RPC ConnectToMaster: received response from server master-127.21.42.126:39809: OK, deferred=null) after lookup
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.487905 21714 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:53796:
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783465681852"
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:08:04.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:08:04.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:08:04.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:04.489277 21714 catalog_manager.cc:7076] 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-1783465681852 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
23:08:04.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.511475 22219 heartbeater.cc:499] Master 127.21.42.126:39809 was elected leader, sending a full tablet report...
23:08:04.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.511935 22153 tablet_service.cc:1511] Processing CreateTablet for tablet 25344921b2174fa5bfc26fa3af787296 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783465681852 [id=87633b2c0f90499fb075831860d40c9b]), partition=RANGE (key) PARTITION UNBOUNDED
23:08:04.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.512938 22153 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 25344921b2174fa5bfc26fa3af787296. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:04.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.516883 22018 tablet_service.cc:1511] Processing CreateTablet for tablet 25344921b2174fa5bfc26fa3af787296 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783465681852 [id=87633b2c0f90499fb075831860d40c9b]), partition=RANGE (key) PARTITION UNBOUNDED
23:08:04.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.517721 22018 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 25344921b2174fa5bfc26fa3af787296. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:04.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.522435 22288 tablet_service.cc:1511] Processing CreateTablet for tablet 25344921b2174fa5bfc26fa3af787296 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783465681852 [id=87633b2c0f90499fb075831860d40c9b]), partition=RANGE (key) PARTITION UNBOUNDED
23:08:04.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.523293 22288 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 25344921b2174fa5bfc26fa3af787296. 1 dirs total, 0 dirs full, 0 dirs failed
23:08:04.524 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 87633b2c0f90499fb075831860d40c9b
23:08:04.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.528544 22384 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Bootstrap starting.
23:08:04.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.529336 22385 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Bootstrap starting.
23:08:04.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.530704 22384 tablet_bootstrap.cc:654] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Neither blocks nor log segments found. Creating new log.
23:08:04.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.531564 22385 tablet_bootstrap.cc:654] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Neither blocks nor log segments found. Creating new log.
23:08:04.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.531991 22384 log.cc:826] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Log is configured to *not* fsync() on all Append() calls
23:08:04.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.532109 22383 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Bootstrap starting.
23:08:04.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.532354 22385 log.cc:826] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Log is configured to *not* fsync() on all Append() calls
23:08:04.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.533813 22385 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: No bootstrap required, opened a new log
23:08:04.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.533969 22383 tablet_bootstrap.cc:654] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Neither blocks nor log segments found. Creating new log.
23:08:04.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.534015 22385 ts_tablet_manager.cc:1403] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Time spent bootstrapping tablet: real 0.005s	user 0.000s	sys 0.004s
23:08:04.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.534644 22383 log.cc:826] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Log is configured to *not* fsync() on all Append() calls
23:08:04.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.535477 22384 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: No bootstrap required, opened a new log
23:08:04.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.535640 22384 ts_tablet_manager.cc:1403] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Time spent bootstrapping tablet: real 0.007s	user 0.004s	sys 0.000s
23:08:04.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.536516 22383 tablet_bootstrap.cc:492] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: No bootstrap required, opened a new log
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.536674 22383 ts_tablet_manager.cc:1403] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Time spent bootstrapping tablet: real 0.005s	user 0.004s	sys 0.000s
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.537346 22385 raft_consensus.cc:359] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.537532 22385 raft_consensus.cc:385] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.537578 22385 raft_consensus.cc:740] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bd7d7418139b4af38d0bc639e219aa88, State: Initialized, Role: FOLLOWER
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.538039 22385 consensus_queue.cc:260] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [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: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.538475 22384 raft_consensus.cc:359] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.538631 22384 raft_consensus.cc:385] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.538676 22384 raft_consensus.cc:740] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 813c8b4bfdd34d44b56f7e719207415f, State: Initialized, Role: FOLLOWER
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.538787 22385 ts_tablet_manager.cc:1434] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Time spent starting tablet: real 0.005s	user 0.004s	sys 0.000s
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.539021 22384 consensus_queue.cc:260] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [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: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.539753 22384 ts_tablet_manager.cc:1434] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Time spent starting tablet: real 0.004s	user 0.005s	sys 0.000s
23:08:04.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.540047 22354 heartbeater.cc:499] Master 127.21.42.126:39809 was elected leader, sending a full tablet report...
23:08:04.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.539690 22383 raft_consensus.cc:359] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.542042 22383 raft_consensus.cc:385] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:08:04.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.542099 22383 raft_consensus.cc:740] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 93df6ba09b8d48418d6140ee97f5a868, State: Initialized, Role: FOLLOWER
23:08:04.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.542455 22383 consensus_queue.cc:260] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [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: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.543226 22383 ts_tablet_manager.cc:1434] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Time spent starting tablet: real 0.007s	user 0.004s	sys 0.000s
23:08:04.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:04.568723 22087 tablet.cc:2406] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:08:04.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.680033 22390 raft_consensus.cc:493] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:08:04.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.680260 22390 raft_consensus.cc:515] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.681845 22390 leader_election.cc:290] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers bd7d7418139b4af38d0bc639e219aa88 (127.21.42.66:34421), 93df6ba09b8d48418d6140ee97f5a868 (127.21.42.65:40071)
23:08:04.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:04.684816 22357 tablet.cc:2406] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:08:04.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.686630 22173 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "25344921b2174fa5bfc26fa3af787296" candidate_uuid: "813c8b4bfdd34d44b56f7e719207415f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bd7d7418139b4af38d0bc639e219aa88" is_pre_election: true
23:08:04.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.686746 22038 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "25344921b2174fa5bfc26fa3af787296" candidate_uuid: "813c8b4bfdd34d44b56f7e719207415f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "93df6ba09b8d48418d6140ee97f5a868" is_pre_election: true
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.686914 22173 raft_consensus.cc:2468] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 813c8b4bfdd34d44b56f7e719207415f in term 0.
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.686972 22038 raft_consensus.cc:2468] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 813c8b4bfdd34d44b56f7e719207415f in term 0.
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.687390 22243 leader_election.cc:304] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [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: 813c8b4bfdd34d44b56f7e719207415f, 93df6ba09b8d48418d6140ee97f5a868; no voters: 
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.687608 22390 raft_consensus.cc:2804] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Leader pre-election won for term 1
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.687665 22390 raft_consensus.cc:493] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:08:04.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.687700 22390 raft_consensus.cc:3060] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 0 FOLLOWER]: Advancing to term 1
23:08:04.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.688657 22390 raft_consensus.cc:515] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.688992 22390 leader_election.cc:290] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [CANDIDATE]: Term 1 election: Requested vote from peers bd7d7418139b4af38d0bc639e219aa88 (127.21.42.66:34421), 93df6ba09b8d48418d6140ee97f5a868 (127.21.42.65:40071)
23:08:04.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.689365 22173 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "25344921b2174fa5bfc26fa3af787296" candidate_uuid: "813c8b4bfdd34d44b56f7e719207415f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bd7d7418139b4af38d0bc639e219aa88"
23:08:04.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.689435 22038 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "25344921b2174fa5bfc26fa3af787296" candidate_uuid: "813c8b4bfdd34d44b56f7e719207415f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "93df6ba09b8d48418d6140ee97f5a868"
23:08:04.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.689471 22173 raft_consensus.cc:3060] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 0 FOLLOWER]: Advancing to term 1
23:08:04.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.689532 22038 raft_consensus.cc:3060] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 0 FOLLOWER]: Advancing to term 1
23:08:04.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.690478 22173 raft_consensus.cc:2468] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 813c8b4bfdd34d44b56f7e719207415f in term 1.
23:08:04.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.690478 22038 raft_consensus.cc:2468] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 813c8b4bfdd34d44b56f7e719207415f in term 1.
23:08:04.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.690749 22242 leader_election.cc:304] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [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: 813c8b4bfdd34d44b56f7e719207415f, bd7d7418139b4af38d0bc639e219aa88; no voters: 
23:08:04.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.690937 22390 raft_consensus.cc:2804] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 1 FOLLOWER]: Leader election won for term 1
23:08:04.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.691147 22390 raft_consensus.cc:697] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [term 1 LEADER]: Becoming Leader. State: Replica: 813c8b4bfdd34d44b56f7e719207415f, State: Running, Role: LEADER
23:08:04.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.691443 22390 consensus_queue.cc:237] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [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: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } }
23:08:04.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.694621 21714 catalog_manager.cc:5696] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f reported cstate change: term changed from 0 to 1, leader changed from <none> to 813c8b4bfdd34d44b56f7e719207415f (127.21.42.67). New cstate: current_term: 1 leader_uuid: "813c8b4bfdd34d44b56f7e719207415f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "813c8b4bfdd34d44b56f7e719207415f" member_type: VOTER last_known_addr { host: "127.21.42.67" port: 44813 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 } health_report { overall_health: UNKNOWN } } }
23:08:04.724 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 25344921b2174fa5bfc26fa3af787296 for table 'org.apache.kudu.client.TestHybridTime-1783465681852' with partition [<start>, <end>)
23:08:04.730 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=25344921b2174fa5bfc26fa3af787296@[813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)[L],93df6ba09b8d48418d6140ee97f5a868(127.21.42.65:40071),bd7d7418139b4af38d0bc639e219aa88(127.21.42.66:34421)]}]
23:08:04.731 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=15), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.21.42.126:39809, [7ms] Sub RPC GetTableLocations: received response from server master-127.21.42.126:39809: OK, deferred=null) after lookup
23:08:04.740 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)] connecting to peer
23:08:04.742 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)] Successfully connected to peer
23:08:04.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:08:04.749650 22222 tablet.cc:2406] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:08:04.808 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x6320d6b6, L:/127.0.0.1:41234 - R:/127.21.42.67:44813] using TOKEN/null
23:08:04.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.815711 22038 raft_consensus.cc:1275] T 25344921b2174fa5bfc26fa3af787296 P 93df6ba09b8d48418d6140ee97f5a868 [term 1 FOLLOWER]: Refusing update from remote peer 813c8b4bfdd34d44b56f7e719207415f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:08:04.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.815714 22173 raft_consensus.cc:1275] T 25344921b2174fa5bfc26fa3af787296 P bd7d7418139b4af38d0bc639e219aa88 [term 1 FOLLOWER]: Refusing update from remote peer 813c8b4bfdd34d44b56f7e719207415f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
23:08:04.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.816454 22390 consensus_queue.cc:1048] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [LEADER]: Connected to new peer: Peer: permanent_uuid: "bd7d7418139b4af38d0bc639e219aa88" member_type: VOTER last_known_addr { host: "127.21.42.66" port: 34421 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:08:04.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.816891 22390 consensus_queue.cc:1048] T 25344921b2174fa5bfc26fa3af787296 P 813c8b4bfdd34d44b56f7e719207415f [LEADER]: Connected to new peer: Peer: permanent_uuid: "93df6ba09b8d48418d6140ee97f5a868" member_type: VOTER last_known_addr { host: "127.21.42.65" port: 40071 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:08:04.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.831890 22398 mvcc.cc:204] Tried to move back new op lower bound from 7305075444998103040 to 7305075444499529728. Current Snapshot: MvccSnapshot[applied={T|T < 7305075444998103040}]
23:08:04.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:04.840438 22400 mvcc.cc:204] Tried to move back new op lower bound from 7305075444998103040 to 7305075444499529728. Current Snapshot: MvccSnapshot[applied={T|T < 7305075444998103040}]
23:08:04.866 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.876 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.882 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.892 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1646549299(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:08:04.902 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.902 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@703251409(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:08:04.908 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.909 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@522260459(state=PENDING, result=null, callback=<none>, errback=<none>)}
23:08:04.915 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
23:08:04.964 [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-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.970 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305075465478103041) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.973 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305075465478103045) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.977 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305075465478103049) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.980 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305075465478103053) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.984 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305075465478103057) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.987 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305075465478103061) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.990 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305075465478103062) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783465681852, tablet=25344921b2174fa5bfc26fa3af787296, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:08:04.993 [DEBUG - main] (Connection.java:575) [peer master-127.21.42.124:42667(127.21.42.124:42667)] disconnecting while in state READY
23:08:04.994 [DEBUG - main] (Connection.java:575) [peer master-127.21.42.125:37859(127.21.42.125:37859)] disconnecting while in state READY
23:08:04.996 [DEBUG - main] (Connection.java:575) [peer 813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)] disconnecting while in state READY
23:08:04.996 [DEBUG - main] (Connection.java:575) [peer master-127.21.42.126:39809(127.21.42.126:39809)] disconnecting while in state READY
23:08:04.998 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.21.42.125:37859(127.21.42.125:37859)] handling channelInactive
23:08:04.998 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.21.42.124:42667(127.21.42.124:42667)] handling channelInactive
23:08:04.999 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.21.42.125:37859(127.21.42.125:37859)] cleaning up while in state READY due to: connection closed
23:08:04.999 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.21.42.124:42667(127.21.42.124:42667)] cleaning up while in state READY due to: connection closed
23:08:05.000 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.21.42.126:39809(127.21.42.126:39809)] handling channelInactive
23:08:05.001 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.21.42.126:39809(127.21.42.126:39809)] cleaning up while in state READY due to: connection closed
23:08:05.002 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
23:08:05.012 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)] handling channelInactive
23:08:05.012 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 813c8b4bfdd34d44b56f7e719207415f(127.21.42.67:44813)] cleaning up while in state READY due to: connection closed
23:08:05.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.012727 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 21956
23:08:05.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.022282 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 22091
23:08:05.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.032795 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 22226
23:08:05.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.039455 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 21684
23:08:05.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.046234 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 21753
23:08:05.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:08:05.053141 21673 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCqdbEn/build/debug/bin/kudu with pid 21825
23:08:05.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:08:05Z chronyd exiting

Time: 3.161

OK (1 test)

