JUnit version 4.13.2
.02:11:24.086 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783476684077
02:11:24.112 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
02:11:24.166 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
02:11:24.173 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskCOzYhB/test-tmp
02:11:24.178 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
02:11:24.182 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskCOzYhB/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
02:11:24.399 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

02:11:24.417 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:11:24.419 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

02:11:24.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.420856 22535 mini_oidc.cc:150] Starting JWKS server
02:11:24.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.422959 22535 webserver.cc:533] Webserver started at http://127.0.0.1:33003/ using document root <none> and password file <none>
02:11:24.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.423152 22535 mini_oidc.cc:186] Starting OIDC Discovery server
02:11:24.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.423446 22535 webserver.cc:533] Webserver started at http://127.0.0.1:37945/ using document root <none> and password file <none>
02:11:24.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:24Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
02:11:24.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:24Z Disabled control of system clock
02:11:24.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.442145 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal
02:11:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data
02:11:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:24.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:24.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:24.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/logs
02:11:24.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data/info.pb
02:11:24.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:24.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:24.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:24.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:24.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.254:37541
02:11:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.254
02:11:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json with env {}
02:11:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.548355 22546 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.548578 22546 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.548637 22546 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552317 22546 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552398 22546 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552429 22546 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552459 22546 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:24.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552491 22546 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:24.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.552511 22546 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33003/jwks.json
02:11:24.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.556783 22546 master_runner.cc:387] Master server non-default flags:
02:11:24.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data
02:11:24.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal
02:11:24.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.254:37541
02:11:24.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:24.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json
02:11:24.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data/info.pb
02:11:24.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.254
02:11:24.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22546
02:11:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:24.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:24.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/logs
02:11:24.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:24.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:24.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:24.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:24.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:24.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:24.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:24.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:24.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.558073 22546 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:24.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.559406 22546 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:24.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.565855 22552 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
02:11:24.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.565851 22551 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
02:11:24.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.565851 22554 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
02:11:24.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.567492 22546 server_base.cc:1061] running on GCE node
02:11:24.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.567885 22546 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:24.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.568725 22546 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:24.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.569898 22546 hybrid_clock.cc:648] HybridClock initialized: now 1783476684569872 us; error 45 us; skew 500 ppm
02:11:24.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.571556 22546 webserver.cc:533] Webserver started at http://127.22.1.254:45345/ using document root <none> and password file <none>
02:11:24.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.572258 22546 fs_manager.cc:362] Metadata directory not provided
02:11:24.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.572345 22546 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:24.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.572600 22546 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.574220 22546 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data/instance:
02:11:24.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f9b3c36855b04de8877c5719ba94de24"
02:11:24.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.574775 22546 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal/instance:
02:11:24.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f9b3c36855b04de8877c5719ba94de24"
02:11:24.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.578213 22546 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
02:11:24.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.580314 22560 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:24.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.581274 22546 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
02:11:24.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.581362 22546 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal
02:11:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f9b3c36855b04de8877c5719ba94de24"
02:11:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.581423 22546 fs_report.cc:389] FS layout report
02:11:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:24.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal
02:11:24.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal
02:11:24.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data/data
02:11:24.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:24.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:24.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:24.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:24.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:24.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:24.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.593612 22546 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:24.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.594130 22546 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:24.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.594280 22546 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:24.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.600936 22546 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.254:37541
02:11:24.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.600935 22612 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.254:37541 every 8 connection(s)
02:11:24.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.601864 22546 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/data/info.pb
02:11:24.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.603941 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 22546
02:11:24.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.604101 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-0/wal/instance
02:11:24.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.604820 22613 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:24.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.605911 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal
02:11:24.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/logs
02:11:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data/info.pb
02:11:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:24.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:24.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:24.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:24.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.253:36971
02:11:24.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.253
02:11:24.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json with env {}
02:11:24.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.608492 22613 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.624720 22613 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.626200 22564 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.22.1.253:36971: connect: Connection refused (error 111)
02:11:24.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.627126 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.253:36971: Network error: Client connection negotiation failed: client connection to 127.22.1.253:36971: connect: Connection refused (error 111)
02:11:24.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.676342 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } attempt: 1
02:11:24.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.677975 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.253:36971: Network error: Client connection negotiation failed: client connection to 127.22.1.253:36971: connect: Connection refused (error 111)
02:11:24.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.713056 22615 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:24.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.713328 22615 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:24.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.713392 22615 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:24.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717027 22615 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:24.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717126 22615 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:24.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717157 22615 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:24.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717183 22615 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:24.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717211 22615 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:24.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.717229 22615 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33003/jwks.json
02:11:24.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.721519 22615 master_runner.cc:387] Master server non-default flags:
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data
02:11:24.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal
02:11:24.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.253:36971
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json
02:11:24.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data/info.pb
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.253
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:24.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22615
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/logs
02:11:24.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:24.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:24.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:24.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:24.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.722976 22615 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:24.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.724527 22615 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:24.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.730942 22626 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
02:11:24.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.730930 22624 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
02:11:24.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.731302 22623 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
02:11:24.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.731504 22615 server_base.cc:1061] running on GCE node
02:11:24.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.732129 22615 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:24.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.733131 22615 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:24.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.734344 22615 hybrid_clock.cc:648] HybridClock initialized: now 1783476684734306 us; error 56 us; skew 500 ppm
02:11:24.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.736229 22615 webserver.cc:533] Webserver started at http://127.22.1.253:40625/ using document root <none> and password file <none>
02:11:24.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.736822 22615 fs_manager.cc:362] Metadata directory not provided
02:11:24.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.736900 22615 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:24.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.737135 22615 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:24.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.739046 22615 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data/instance:
02:11:24.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d293e03a64f84106b2d5de3e0b255e56"
02:11:24.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.739568 22615 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal/instance:
02:11:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d293e03a64f84106b2d5de3e0b255e56"
02:11:24.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.743108 22615 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
02:11:24.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.745610 22632 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.746153 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } attempt: 2
02:11:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.746729 22615 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
02:11:24.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.746850 22615 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d293e03a64f84106b2d5de3e0b255e56"
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.746929 22615 fs_report.cc:389] FS layout report
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data/data
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:24.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:24.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.747901 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.253:36971: Network error: Client connection negotiation failed: client connection to 127.22.1.253:36971: connect: Connection refused (error 111)
02:11:24.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.764955 22615 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:24.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.765555 22615 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:24.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.765692 22615 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:24.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.774554 22684 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.253:36971 every 8 connection(s)
02:11:24.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.774555 22615 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.253:36971
02:11:24.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.775828 22615 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/data/info.pb
02:11:24.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.776180 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 22615
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.776276 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-1/wal/instance
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.776988 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data
02:11:24.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/logs
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data/info.pb
02:11:24.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.252:41575
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.252
02:11:24.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json with env {}
02:11:24.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.779569 22685 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:24.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.783620 22685 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.793460 22685 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.799130 22685 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.799832 22636 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.800701 22685 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.839088 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } attempt: 3
02:11:24.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.843699 22613 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.845155 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.849928 22685 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 1
02:11:24.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.851347 22685 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.876332 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 1
02:11:24.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.877876 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.887617 22687 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.887799 22687 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.887842 22687 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891072 22687 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891124 22687 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891142 22687 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891160 22687 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891176 22687 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:11:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.891191 22687 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33003/jwks.json
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.894994 22687 master_runner.cc:387] Master server non-default flags:
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:24.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.252:41575
02:11:24.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33003/jwks.json
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data/info.pb
02:11:24.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.252
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22687
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:24.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/logs
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:11:24.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.895998 22687 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:24.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.897145 22687 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:24.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.903164 22698 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
02:11:24.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.903337 22695 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
02:11:24.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.903574 22696 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
02:11:24.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.904950 22687 server_base.cc:1061] running on GCE node
02:11:24.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.905504 22687 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:24.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.906553 22687 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:24.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.907742 22687 hybrid_clock.cc:648] HybridClock initialized: now 1783476684907682 us; error 73 us; skew 500 ppm
02:11:24.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.909714 22687 webserver.cc:533] Webserver started at http://127.22.1.252:45237/ using document root <none> and password file <none>
02:11:24.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.910368 22687 fs_manager.cc:362] Metadata directory not provided
02:11:24.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.910447 22687 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:24.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.910676 22687 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:24.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.912524 22687 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data/instance:
02:11:24.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d583cb11daaa43da910ee7a4cf6792d0"
02:11:24.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.912946 22687 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal/instance:
02:11:24.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d583cb11daaa43da910ee7a4cf6792d0"
02:11:24.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.916168 22687 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
02:11:24.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.918162 22704 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.919073 22687 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.919245 22687 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d583cb11daaa43da910ee7a4cf6792d0"
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:24 on dist-test-slave-zwgk"
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.919368 22687 fs_report.cc:389] FS layout report
02:11:24.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data/data
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:24.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.919533 22685 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 2
02:11:24.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.920930 22685 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.949632 22687 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:24.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.950433 22687 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:24.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.950646 22687 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:24.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.953171 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 2
02:11:24.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.954785 22613 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.22.1.252:41575: Network error: Client connection negotiation failed: client connection to 127.22.1.252:41575: connect: Connection refused (error 111)
02:11:24.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.958371 22756 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.252:41575 every 8 connection(s)
02:11:24.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.958385 22687 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.252:41575
02:11:24.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.959357 22687 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/data/info.pb
02:11:24.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.962363 22757 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.964578 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 22687
02:11:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.964701 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/master-2/wal/instance
02:11:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.965265 22757 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.974328 22757 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.978804 22757 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } has no permanent_uuid. Determining permanent_uuid...
02:11:24.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.985361 22757 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: Bootstrap starting.
02:11:24.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.987586 22757 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: Neither blocks nor log segments found. Creating new log.
02:11:24.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.988420 22757 log.cc:826] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: Log is configured to *not* fsync() on all Append() calls
02:11:24.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.989995 22757 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: No bootstrap required, opened a new log
02:11:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.993201 22757 raft_consensus.cc:359] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.993358 22757 raft_consensus.cc:385] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.993392 22757 raft_consensus.cc:740] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d583cb11daaa43da910ee7a4cf6792d0, State: Initialized, Role: FOLLOWER
02:11:24.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.993721 22757 consensus_queue.cc:260] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:24.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.994143 22766 sys_catalog.cc:455] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:24.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.994275 22766 sys_catalog.cc:458] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: This master's current role is: FOLLOWER
02:11:24.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.994695 22757 sys_catalog.cc:565] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: configured and running, proceeding with master startup.
02:11:24.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.999708 22777 catalog_manager.cc:1594] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:11:25.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:24.999787 22777 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:11:25.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:24.999073 22687 master_runner.cc:187] Error getting master registration for 127.22.1.254:37541: OK, instance_id { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" instance_seqno: 1783476684599222 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:11:25.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.001003 22687 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:25.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.012145 22685 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 3
02:11:25.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.018359 22685 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: Bootstrap starting.
02:11:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.020772 22685 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: Neither blocks nor log segments found. Creating new log.
02:11:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.021693 22685 log.cc:826] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: Log is configured to *not* fsync() on all Append() calls
02:11:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.023313 22685 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: No bootstrap required, opened a new log
02:11:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.026144 22685 raft_consensus.cc:359] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.026317 22685 raft_consensus.cc:385] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.026369 22685 raft_consensus.cc:740] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d293e03a64f84106b2d5de3e0b255e56, State: Initialized, Role: FOLLOWER
02:11:25.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.026842 22685 consensus_queue.cc:260] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.027367 22780 sys_catalog.cc:455] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.027479 22780 sys_catalog.cc:458] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.028095 22685 sys_catalog.cc:565] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: configured and running, proceeding with master startup.
02:11:25.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.033316 22791 catalog_manager.cc:1594] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:11:25.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.033675 22791 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:11:25.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.031843 22615 master_runner.cc:187] Error getting master registration for 127.22.1.254:37541: OK, instance_id { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" instance_seqno: 1783476684599222 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:11:25.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.034117 22615 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:25.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.053951 22613 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } attempt: 3
02:11:25.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.061950 22613 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: Bootstrap starting.
02:11:25.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.064662 22613 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: Neither blocks nor log segments found. Creating new log.
02:11:25.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.065478 22613 log.cc:826] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: Log is configured to *not* fsync() on all Append() calls
02:11:25.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.067404 22613 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: No bootstrap required, opened a new log
02:11:25.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.072201 22613 raft_consensus.cc:359] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.072386 22613 raft_consensus.cc:385] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:25.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.072443 22613 raft_consensus.cc:740] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f9b3c36855b04de8877c5719ba94de24, State: Initialized, Role: FOLLOWER
02:11:25.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.073247 22613 consensus_queue.cc:260] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.073814 22794 sys_catalog.cc:455] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.074236 22794 sys_catalog.cc:458] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.074520 22613 sys_catalog.cc:565] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: configured and running, proceeding with master startup.
02:11:25.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.079846 22805 catalog_manager.cc:1594] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:11:25.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.080343 22805 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:11:25.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.091454 22546 master_runner.cc:264] No leader master found from master f9b3c36855b04de8877c5719ba94de24
02:11:25.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.091558 22546 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:11:25.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.095508 22566 tablet.cc:2406] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:25.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.187219 22766 raft_consensus.cc:493] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:11:25.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.187415 22766 raft_consensus.cc:515] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.189468 22766 leader_election.cc:290] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers f9b3c36855b04de8877c5719ba94de24 (127.22.1.254:37541), d293e03a64f84106b2d5de3e0b255e56 (127.22.1.253:36971)
02:11:25.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.190178 22659 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d583cb11daaa43da910ee7a4cf6792d0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d293e03a64f84106b2d5de3e0b255e56" is_pre_election: true
02:11:25.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.190438 22659 raft_consensus.cc:2468] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d583cb11daaa43da910ee7a4cf6792d0 in term 0.
02:11:25.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.190901 22708 leader_election.cc:304] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [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: d293e03a64f84106b2d5de3e0b255e56, d583cb11daaa43da910ee7a4cf6792d0; no voters: 
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.192852 22587 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d583cb11daaa43da910ee7a4cf6792d0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f9b3c36855b04de8877c5719ba94de24" is_pre_election: true
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.193152 22587 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d583cb11daaa43da910ee7a4cf6792d0 in term 0.
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.193516 22766 raft_consensus.cc:2804] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Leader pre-election won for term 1
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.193586 22766 raft_consensus.cc:493] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.193631 22766 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 0 FOLLOWER]: Advancing to term 1
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.194814 22766 raft_consensus.cc:515] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.195209 22766 leader_election.cc:290] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [CANDIDATE]: Term 1 election: Requested vote from peers f9b3c36855b04de8877c5719ba94de24 (127.22.1.254:37541), d293e03a64f84106b2d5de3e0b255e56 (127.22.1.253:36971)
02:11:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.195693 22659 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d583cb11daaa43da910ee7a4cf6792d0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d293e03a64f84106b2d5de3e0b255e56"
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.195811 22659 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 0 FOLLOWER]: Advancing to term 1
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.196991 22659 raft_consensus.cc:2468] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d583cb11daaa43da910ee7a4cf6792d0 in term 1.
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.197326 22708 leader_election.cc:304] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [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: d293e03a64f84106b2d5de3e0b255e56, d583cb11daaa43da910ee7a4cf6792d0; no voters: 
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.197983 22587 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d583cb11daaa43da910ee7a4cf6792d0" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f9b3c36855b04de8877c5719ba94de24"
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.198112 22587 raft_consensus.cc:3060] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 0 FOLLOWER]: Advancing to term 1
02:11:25.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.199604 22587 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d583cb11daaa43da910ee7a4cf6792d0 in term 1.
02:11:25.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.201990 22710 tablet.cc:2406] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:25.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.204002 22766 raft_consensus.cc:2804] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 1 FOLLOWER]: Leader election won for term 1
02:11:25.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.204284 22766 raft_consensus.cc:697] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [term 1 LEADER]: Becoming Leader. State: Replica: d583cb11daaa43da910ee7a4cf6792d0, State: Running, Role: LEADER
02:11:25.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.204612 22766 consensus_queue.cc:237] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [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: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } }
02:11:25.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.213636 22766 sys_catalog.cc:455] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: SysCatalogTable state changed. Reason: New leader d583cb11daaa43da910ee7a4cf6792d0. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.213788 22766 sys_catalog.cc:458] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: This master's current role is: LEADER
02:11:25.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.221029 22809 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
02:11:25.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.222414 22809 catalog_manager.cc:1520] Initializing Kudu cluster ID...
02:11:25.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.230057 22587 raft_consensus.cc:1275] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [term 1 FOLLOWER]: Refusing update from remote peer d583cb11daaa43da910ee7a4cf6792d0: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:25.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.230057 22659 raft_consensus.cc:1275] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [term 1 FOLLOWER]: Refusing update from remote peer d583cb11daaa43da910ee7a4cf6792d0: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:25.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.230717 22766 consensus_queue.cc:1048] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [LEADER]: Connected to new peer: Peer: permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:25.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.231130 22766 consensus_queue.cc:1048] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.234721 22780 sys_catalog.cc:455] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: SysCatalogTable state changed. Reason: New leader d583cb11daaa43da910ee7a4cf6792d0. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.234732 22794 sys_catalog.cc:455] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: SysCatalogTable state changed. Reason: New leader d583cb11daaa43da910ee7a4cf6792d0. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.234838 22794 sys_catalog.cc:458] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.234838 22780 sys_catalog.cc:458] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.238996 22766 sys_catalog.cc:455] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.239126 22766 sys_catalog.cc:458] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: This master's current role is: LEADER
02:11:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.239629 22811 sys_catalog.cc:455] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.239730 22811 sys_catalog.cc:458] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0 [sys.catalog]: This master's current role is: LEADER
02:11:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.240237 22780 sys_catalog.cc:455] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.240345 22780 sys_catalog.cc:458] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.240981 22813 mvcc.cc:204] Tried to move back new op lower bound from 7305120502695190528 to 7305120502630285312. Current Snapshot: MvccSnapshot[applied={T|T < 7305120502695190528}]
02:11:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.241659 22794 sys_catalog.cc:455] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "d583cb11daaa43da910ee7a4cf6792d0" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f9b3c36855b04de8877c5719ba94de24" member_type: VOTER last_known_addr { host: "127.22.1.254" port: 37541 } } peers { permanent_uuid: "d293e03a64f84106b2d5de3e0b255e56" member_type: VOTER last_known_addr { host: "127.22.1.253" port: 36971 } } peers { permanent_uuid: "d583cb11daaa43da910ee7a4cf6792d0" member_type: VOTER last_known_addr { host: "127.22.1.252" port: 41575 } } }
02:11:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.241762 22794 sys_catalog.cc:458] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24 [sys.catalog]: This master's current role is: FOLLOWER
02:11:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.242894 22812 mvcc.cc:204] Tried to move back new op lower bound from 7305120502695190528 to 7305120502630285312. Current Snapshot: MvccSnapshot[applied={T|T < 7305120502695190528}]
02:11:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.243031 22809 catalog_manager.cc:1383] Generated new cluster ID: 92a531ddafb9413d9babae9943d7e6c7
02:11:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.243084 22809 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
02:11:25.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.259140 22809 catalog_manager.cc:1406] Generated new certificate authority record
02:11:25.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.260739 22809 catalog_manager.cc:1540] Loading token signing keys...
02:11:25.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.269315 22809 catalog_manager.cc:6070] T 00000000000000000000000000000000 P d583cb11daaa43da910ee7a4cf6792d0: Generated new TSK 0
02:11:25.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.270366 22809 catalog_manager.cc:1550] Initializing in-progress tserver states...
02:11:25.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.286321 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/logs
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data/info.pb
02:11:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.193:0
02:11:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.193
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.193
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:11:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.395226 22819 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.395478 22819 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:25.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.395539 22819 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:25.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.398725 22819 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:25.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.398815 22819 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.22.1.193
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.402518 22819 tablet_server_runner.cc:78] Tablet server non-default flags:
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.193:0
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data/info.pb
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.193
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22819
02:11:25.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.193
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/logs
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:25.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:25.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:25.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:25.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:25.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.403543 22819 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:25.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.404621 22819 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:25.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.410779 22824 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
02:11:25.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.410785 22825 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
02:11:25.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.411038 22827 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
02:11:25.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.411043 22819 server_base.cc:1061] running on GCE node
02:11:25.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.411815 22819 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:25.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.412413 22819 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:25.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.413604 22819 hybrid_clock.cc:648] HybridClock initialized: now 1783476685413574 us; error 46 us; skew 500 ppm
02:11:25.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.415356 22819 webserver.cc:533] Webserver started at http://127.22.1.193:46007/ using document root <none> and password file <none>
02:11:25.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.415925 22819 fs_manager.cc:362] Metadata directory not provided
02:11:25.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.416009 22819 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:25.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.416299 22819 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.417798 22819 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data/instance:
02:11:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de31c4db13674e3cad33f4aba936d417"
02:11:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.418321 22819 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal/instance:
02:11:25.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de31c4db13674e3cad33f4aba936d417"
02:11:25.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.421640 22819 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
02:11:25.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.423795 22833 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.424906 22819 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.425017 22819 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de31c4db13674e3cad33f4aba936d417"
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.425120 22819 fs_report.cc:389] FS layout report
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data/data
02:11:25.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:25.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:25.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.439553 22819 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.440320 22819 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.440521 22819 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.441156 22819 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:11:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.442193 22819 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:11:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.442260 22819 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:11:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.442315 22819 ts_tablet_manager.cc:616] Registered 0 tablets
02:11:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.442338 22819 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:11:25.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.451488 22819 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.193:41275
02:11:25.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.451514 22946 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.193:41275 every 8 connection(s)
02:11:25.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.452462 22819 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/data/info.pb
02:11:25.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.454119 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 22819
02:11:25.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.454236 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-0/wal/instance
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.457496 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/logs
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data/info.pb
02:11:25.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.194:0
02:11:25.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.194
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.194
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463596 22948 heartbeater.cc:344] Connected to a master server at 127.22.1.254:37541
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463649 22949 heartbeater.cc:344] Connected to a master server at 127.22.1.253:36971
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463708 22947 heartbeater.cc:344] Connected to a master server at 127.22.1.252:41575
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463829 22948 heartbeater.cc:461] Registering TS with master...
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463829 22947 heartbeater.cc:461] Registering TS with master...
02:11:25.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.463830 22949 heartbeater.cc:461] Registering TS with master...
02:11:25.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.464480 22949 heartbeater.cc:507] Master 127.22.1.253:36971 requested a full tablet report, sending...
02:11:25.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.464460 22947 heartbeater.cc:507] Master 127.22.1.252:41575 requested a full tablet report, sending...
02:11:25.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.464473 22948 heartbeater.cc:507] Master 127.22.1.254:37541 requested a full tablet report, sending...
02:11:25.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.466063 22649 ts_manager.cc:194] Registered new tserver with Master: de31c4db13674e3cad33f4aba936d417 (127.22.1.193:41275)
02:11:25.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.466379 22573 ts_manager.cc:194] Registered new tserver with Master: de31c4db13674e3cad33f4aba936d417 (127.22.1.193:41275)
02:11:25.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.467036 22720 ts_manager.cc:194] Registered new tserver with Master: de31c4db13674e3cad33f4aba936d417 (127.22.1.193:41275)
02:11:25.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.468214 22720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.22.1.193:44445
02:11:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.564301 22954 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.564477 22954 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.564517 22954 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.568078 22954 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.568223 22954 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.22.1.194
02:11:25.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.572486 22954 tablet_server_runner.cc:78] Tablet server non-default flags:
02:11:25.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.194:0
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data/info.pb
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.194
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22954
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.194
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/logs
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.573412 22954 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.574384 22954 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:25.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.580281 22962 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
02:11:25.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.580281 22959 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
02:11:25.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.580315 22960 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
02:11:25.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.580549 22954 server_base.cc:1061] running on GCE node
02:11:25.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.580854 22954 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:25.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.581306 22954 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:25.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.582472 22954 hybrid_clock.cc:648] HybridClock initialized: now 1783476685582453 us; error 36 us; skew 500 ppm
02:11:25.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.584107 22954 webserver.cc:533] Webserver started at http://127.22.1.194:46023/ using document root <none> and password file <none>
02:11:25.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.584630 22954 fs_manager.cc:362] Metadata directory not provided
02:11:25.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.584681 22954 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:25.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.584824 22954 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.586237 22954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data/instance:
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f8b5f4e7f224892b09dd63857e27926"
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.586639 22954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal/instance:
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f8b5f4e7f224892b09dd63857e27926"
02:11:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.589627 22954 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.003s
02:11:25.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.591465 22968 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:25.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.592512 22954 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
02:11:25.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.592600 22954 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f8b5f4e7f224892b09dd63857e27926"
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.592664 22954 fs_report.cc:389] FS layout report
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data/data
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:25.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:25.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.617316 22954 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:25.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.618033 22954 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:25.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.618227 22954 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:25.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.618885 22954 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:11:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.619884 22954 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:11:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.619930 22954 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:11:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.619969 22954 ts_tablet_manager.cc:616] Registered 0 tablets
02:11:25.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.619984 22954 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:11:25.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.629544 22954 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.194:42005
02:11:25.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.629562 23081 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.194:42005 every 8 connection(s)
02:11:25.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.630575 22954 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/data/info.pb
02:11:25.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.635938 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 22954
02:11:25.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.636044 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-1/wal/instance
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.639786 22535 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:11:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/logs
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data/info.pb
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.195:0
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.195
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.195
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640092 23083 heartbeater.cc:344] Connected to a master server at 127.22.1.254:37541
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640170 23084 heartbeater.cc:344] Connected to a master server at 127.22.1.253:36971
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640213 23082 heartbeater.cc:344] Connected to a master server at 127.22.1.252:41575
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640326 23084 heartbeater.cc:461] Registering TS with master...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640326 23082 heartbeater.cc:461] Registering TS with master...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640905 23082 heartbeater.cc:507] Master 127.22.1.252:41575 requested a full tablet report, sending...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.640326 23083 heartbeater.cc:461] Registering TS with master...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.641641 23083 heartbeater.cc:507] Master 127.22.1.254:37541 requested a full tablet report, sending...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.642007 23084 heartbeater.cc:507] Master 127.22.1.253:36971 requested a full tablet report, sending...
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.642469 22720 ts_manager.cc:194] Registered new tserver with Master: 7f8b5f4e7f224892b09dd63857e27926 (127.22.1.194:42005)
02:11:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.642758 22649 ts_manager.cc:194] Registered new tserver with Master: 7f8b5f4e7f224892b09dd63857e27926 (127.22.1.194:42005)
02:11:25.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.643203 22720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.22.1.194:53303
02:11:25.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.643466 22573 ts_manager.cc:194] Registered new tserver with Master: 7f8b5f4e7f224892b09dd63857e27926 (127.22.1.194:42005)
02:11:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.740857 23089 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:11:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.741050 23089 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:11:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.741091 23089 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:11:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.744272 23089 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:11:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.744361 23089 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.22.1.195
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.748066 23089 tablet_server_runner.cc:78] Tablet server non-default flags:
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.22.1.212:40961
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.22.1.195:0
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data/info.pb
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.22.1.195
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.22.1.254:37541,127.22.1.253:36971,127.22.1.252:41575
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.23089
02:11:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.22.1.195
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/logs
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:43:16 UTC on bdcb31816ec0
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12764
02:11:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.749039 23089 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:11:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.749956 23089 file_cache.cc:504] Constructed file cache file cache with capacity 419430
02:11:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.755831 23095 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
02:11:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.755826 23097 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
02:11:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:25.755875 23094 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
02:11:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.756502 23089 server_base.cc:1061] running on GCE node
02:11:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.756824 23089 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:11:25.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.757248 23089 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:11:25.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.758406 23089 hybrid_clock.cc:648] HybridClock initialized: now 1783476685758391 us; error 30 us; skew 500 ppm
02:11:25.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.760082 23089 webserver.cc:533] Webserver started at http://127.22.1.195:40687/ using document root <none> and password file <none>
02:11:25.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.760757 23089 fs_manager.cc:362] Metadata directory not provided
02:11:25.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.760812 23089 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:11:25.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.760968 23089 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:11:25.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.762332 23089 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data/instance:
02:11:25.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dd71b671e2204ecbbdd38e191aecab6b"
02:11:25.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.762794 23089 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal/instance:
02:11:25.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dd71b671e2204ecbbdd38e191aecab6b"
02:11:25.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.766650 23089 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
02:11:25.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.769053 23103 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.769945 23089 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.770040 23089 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data,/tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dd71b671e2204ecbbdd38e191aecab6b"
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:11:25 on dist-test-slave-zwgk"
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.770102 23089 fs_report.cc:389] FS layout report
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data/data
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:11:25.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:11:25.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.796100 23089 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:11:25.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.796772 23089 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:11:25.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.796916 23089 kserver.cc:163] Server-wide thread pool size limit: 3276
02:11:25.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.797508 23089 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:11:25.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.798593 23089 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:11:25.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.798638 23089 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:11:25.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.798676 23089 ts_tablet_manager.cc:616] Registered 0 tablets
02:11:25.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.798691 23089 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:11:25.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.806955 23089 rpc_server.cc:307] RPC server started. Bound to: 127.22.1.195:41909
02:11:25.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.807045 23216 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.22.1.195:41909 every 8 connection(s)
02:11:25.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.807806 23089 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/data/info.pb
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816262 22535 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu as pid 23089
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816375 22535 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskCOzYhB/test-tmp/mini-kudu-cluster15899794638042339572/ts-2/wal/instance
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816658 23219 heartbeater.cc:344] Connected to a master server at 127.22.1.253:36971
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816674 23218 heartbeater.cc:344] Connected to a master server at 127.22.1.254:37541
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816857 23218 heartbeater.cc:461] Registering TS with master...
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.816856 23219 heartbeater.cc:461] Registering TS with master...
02:11:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.817423 23218 heartbeater.cc:507] Master 127.22.1.254:37541 requested a full tablet report, sending...
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.817448 23217 heartbeater.cc:344] Connected to a master server at 127.22.1.252:41575
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.817444 23219 heartbeater.cc:507] Master 127.22.1.253:36971 requested a full tablet report, sending...
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.817520 23217 heartbeater.cc:461] Registering TS with master...
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.817672 23217 heartbeater.cc:507] Master 127.22.1.252:41575 requested a full tablet report, sending...
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.818476 22649 ts_manager.cc:194] Registered new tserver with Master: dd71b671e2204ecbbdd38e191aecab6b (127.22.1.195:41909)
02:11:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.818745 22577 ts_manager.cc:194] Registered new tserver with Master: dd71b671e2204ecbbdd38e191aecab6b (127.22.1.195:41909)
02:11:25.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.818907 22720 ts_manager.cc:194] Registered new tserver with Master: dd71b671e2204ecbbdd38e191aecab6b (127.22.1.195:41909)
02:11:25.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.819545 22720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.22.1.195:43289
02:11:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:25.823724 22535 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
02:11:25.824 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:11:25.826 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

02:11:25.835 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.22.1.254"
      port: 37541
    }
    bound_http_address {
      host: "127.22.1.254"
      port: 45345
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.22.1.253"
      port: 36971
    }
    bound_http_address {
      host: "127.22.1.253"
      port: 40625
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.22.1.252"
      port: 41575
    }
    bound_http_address {
      host: "127.22.1.252"
      port: 45237
    }
  }
}

02:11:25.838 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

02:11:25.840 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.22.1.193"
      port: 41275
    }
    bound_http_address {
      host: "127.22.1.193"
      port: 46007
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.22.1.194"
      port: 42005
    }
    bound_http_address {
      host: "127.22.1.194"
      port: 46023
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.22.1.195"
      port: 41909
    }
    bound_http_address {
      host: "127.22.1.195"
      port: 40687
    }
  }
}

02:11:25.840 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
02:11:26.003 [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.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	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)
02:11:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.035354 22791 catalog_manager.cc:1295] Loaded cluster ID: 92a531ddafb9413d9babae9943d7e6c7
02:11:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.035434 22791 catalog_manager.cc:1588] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: loading cluster ID for follower catalog manager: success
02:11:26.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.038443 22791 catalog_manager.cc:1610] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: acquiring CA information for follower catalog manager: success
02:11:26.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.040284 22791 catalog_manager.cc:1638] T 00000000000000000000000000000000 P d293e03a64f84106b2d5de3e0b255e56: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:11:26.053 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
02:11:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.082403 22805 catalog_manager.cc:1295] Loaded cluster ID: 92a531ddafb9413d9babae9943d7e6c7
02:11:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.082489 22805 catalog_manager.cc:1588] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: loading cluster ID for follower catalog manager: success
02:11:26.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.085417 22805 catalog_manager.cc:1610] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: acquiring CA information for follower catalog manager: success
02:11:26.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.086731 22805 catalog_manager.cc:1638] T 00000000000000000000000000000000 P f9b3c36855b04de8877c5719ba94de24: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:11:26.191 [DEBUG - main] (Connection.java:748) [peer master-127.22.1.254:37541(127.22.1.254:37541)] connecting to peer
02:11:26.255 [DEBUG - main] (Connection.java:748) [peer master-127.22.1.252:41575(127.22.1.252:41575)] connecting to peer
02:11:26.256 [DEBUG - main] (Connection.java:748) [peer master-127.22.1.253:36971(127.22.1.253:36971)] connecting to peer
02:11:26.273 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.22.1.253:36971(127.22.1.253:36971)] Successfully connected to peer
02:11:26.273 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.22.1.254:37541(127.22.1.254:37541)] Successfully connected to peer
02:11:26.273 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.22.1.252:41575(127.22.1.252:41575)] Successfully connected to peer
02:11:26.356 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.22.1.253
02:11:26.356 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.22.1.252
02:11:26.364 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.22.1.254
02:11:26.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.469795 22947 heartbeater.cc:499] Master 127.22.1.252:41575 was elected leader, sending a full tablet report...
02:11:26.572 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x148f08f5, L:/127.0.0.1:50902 - R:/127.22.1.254:37541] using SASL/PLAIN
02:11:26.572 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x35c2fc00, L:/127.0.0.1:47142 - R:/127.22.1.252:41575] using SASL/PLAIN
02:11:26.572 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xaad3a2a1, L:/127.0.0.1:50990 - R:/127.22.1.253:36971] using SASL/PLAIN
02:11:26.610 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
02:11:26.611 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=456), Traces: [0ms] refreshing cache from master, [24ms] Sub RPC ConnectToMaster: sending RPC to server master-127.22.1.254:37541, [97ms] Sub RPC ConnectToMaster: sending RPC to server master-127.22.1.252:41575, [99ms] Sub RPC ConnectToMaster: sending RPC to server master-127.22.1.253:36971, [429ms] Sub RPC ConnectToMaster: received response from server master-127.22.1.254:37541: OK, [429ms] Sub RPC ConnectToMaster: received response from server master-127.22.1.253:36971: OK, [430ms] Sub RPC ConnectToMaster: received response from server master-127.22.1.252:41575: OK, deferred=null) after lookup
02:11:26.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.644819 23082 heartbeater.cc:499] Master 127.22.1.252:41575 was elected leader, sending a full tablet report...
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.654263 22720 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:47142:
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783476683972"
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
02:11:26.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:11:26.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:26.655594 22720 catalog_manager.cc:7077] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783476683972 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
02:11:26.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.678239 23151 tablet_service.cc:1511] Processing CreateTablet for tablet 8438821744f74dfdb6f4db4c5fa1e53c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476683972 [id=72b3d5fc1a2e48b18c42be61d33f8060]), partition=RANGE (key) PARTITION UNBOUNDED
02:11:26.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.679344 23151 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8438821744f74dfdb6f4db4c5fa1e53c. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:26.688 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 72b3d5fc1a2e48b18c42be61d33f8060
02:11:26.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.692209 23016 tablet_service.cc:1511] Processing CreateTablet for tablet 8438821744f74dfdb6f4db4c5fa1e53c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476683972 [id=72b3d5fc1a2e48b18c42be61d33f8060]), partition=RANGE (key) PARTITION UNBOUNDED
02:11:26.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.693102 23016 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8438821744f74dfdb6f4db4c5fa1e53c. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:26.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.694639 22881 tablet_service.cc:1511] Processing CreateTablet for tablet 8438821744f74dfdb6f4db4c5fa1e53c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476683972 [id=72b3d5fc1a2e48b18c42be61d33f8060]), partition=RANGE (key) PARTITION UNBOUNDED
02:11:26.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.695528 22881 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 8438821744f74dfdb6f4db4c5fa1e53c. 1 dirs total, 0 dirs full, 0 dirs failed
02:11:26.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.697284 23246 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Bootstrap starting.
02:11:26.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.699060 23247 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Bootstrap starting.
02:11:26.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.701332 23247 tablet_bootstrap.cc:654] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Neither blocks nor log segments found. Creating new log.
02:11:26.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.702389 23247 log.cc:826] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Log is configured to *not* fsync() on all Append() calls
02:11:26.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.703214 23248 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Bootstrap starting.
02:11:26.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.705571 23248 tablet_bootstrap.cc:654] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Neither blocks nor log segments found. Creating new log.
02:11:26.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.706735 23246 tablet_bootstrap.cc:654] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Neither blocks nor log segments found. Creating new log.
02:11:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.707077 23248 log.cc:826] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Log is configured to *not* fsync() on all Append() calls
02:11:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.707255 23247 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: No bootstrap required, opened a new log
02:11:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.707477 23246 log.cc:826] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Log is configured to *not* fsync() on all Append() calls
02:11:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.707823 23247 ts_tablet_manager.cc:1403] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Time spent bootstrapping tablet: real 0.009s	user 0.005s	sys 0.000s
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.708786 23248 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: No bootstrap required, opened a new log
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.708952 23248 ts_tablet_manager.cc:1403] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Time spent bootstrapping tablet: real 0.006s	user 0.001s	sys 0.003s
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.711421 23247 raft_consensus.cc:359] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.711632 23247 raft_consensus.cc:385] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.711680 23247 raft_consensus.cc:740] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7f8b5f4e7f224892b09dd63857e27926, State: Initialized, Role: FOLLOWER
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.712178 23247 consensus_queue.cc:260] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [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: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.712062 23248 raft_consensus.cc:359] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.712908 23248 raft_consensus.cc:385] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.712987 23247 ts_tablet_manager.cc:1434] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Time spent starting tablet: real 0.005s	user 0.001s	sys 0.003s
02:11:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.713191 23248 raft_consensus.cc:740] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: de31c4db13674e3cad33f4aba936d417, State: Initialized, Role: FOLLOWER
02:11:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.713733 23248 consensus_queue.cc:260] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [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: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.714512 23248 ts_tablet_manager.cc:1434] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Time spent starting tablet: real 0.006s	user 0.004s	sys 0.000s
02:11:26.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.717711 23246 tablet_bootstrap.cc:492] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: No bootstrap required, opened a new log
02:11:26.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.717905 23246 ts_tablet_manager.cc:1403] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Time spent bootstrapping tablet: real 0.021s	user 0.004s	sys 0.000s
02:11:26.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.720963 23246 raft_consensus.cc:359] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.721182 23246 raft_consensus.cc:385] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:11:26.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.721235 23246 raft_consensus.cc:740] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: dd71b671e2204ecbbdd38e191aecab6b, State: Initialized, Role: FOLLOWER
02:11:26.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.721639 23246 consensus_queue.cc:260] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [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: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.722622 23217 heartbeater.cc:499] Master 127.22.1.252:41575 was elected leader, sending a full tablet report...
02:11:26.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.722766 23246 ts_tablet_manager.cc:1434] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Time spent starting tablet: real 0.005s	user 0.005s	sys 0.000s
02:11:26.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:26.809417 23220 tablet.cc:2406] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:26.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.867472 23254 raft_consensus.cc:493] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:11:26.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.867674 23254 raft_consensus.cc:515] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.868763 23254 leader_election.cc:290] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 7f8b5f4e7f224892b09dd63857e27926 (127.22.1.194:42005), de31c4db13674e3cad33f4aba936d417 (127.22.1.193:41275)
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.872875 22901 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8438821744f74dfdb6f4db4c5fa1e53c" candidate_uuid: "dd71b671e2204ecbbdd38e191aecab6b" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "de31c4db13674e3cad33f4aba936d417" is_pre_election: true
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.872875 23036 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8438821744f74dfdb6f4db4c5fa1e53c" candidate_uuid: "dd71b671e2204ecbbdd38e191aecab6b" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7f8b5f4e7f224892b09dd63857e27926" is_pre_election: true
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873127 22901 raft_consensus.cc:2468] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate dd71b671e2204ecbbdd38e191aecab6b in term 0.
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873139 23036 raft_consensus.cc:2468] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate dd71b671e2204ecbbdd38e191aecab6b in term 0.
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873566 23105 leader_election.cc:304] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [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: dd71b671e2204ecbbdd38e191aecab6b, de31c4db13674e3cad33f4aba936d417; no voters: 
02:11:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873813 23254 raft_consensus.cc:2804] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Leader pre-election won for term 1
02:11:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873880 23254 raft_consensus.cc:493] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:11:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.873909 23254 raft_consensus.cc:3060] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 0 FOLLOWER]: Advancing to term 1
02:11:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.874780 23254 raft_consensus.cc:515] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.875073 23254 leader_election.cc:290] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [CANDIDATE]: Term 1 election: Requested vote from peers 7f8b5f4e7f224892b09dd63857e27926 (127.22.1.194:42005), de31c4db13674e3cad33f4aba936d417 (127.22.1.193:41275)
02:11:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.875437 22901 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8438821744f74dfdb6f4db4c5fa1e53c" candidate_uuid: "dd71b671e2204ecbbdd38e191aecab6b" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "de31c4db13674e3cad33f4aba936d417"
02:11:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.875453 23036 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "8438821744f74dfdb6f4db4c5fa1e53c" candidate_uuid: "dd71b671e2204ecbbdd38e191aecab6b" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7f8b5f4e7f224892b09dd63857e27926"
02:11:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.875535 22901 raft_consensus.cc:3060] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 0 FOLLOWER]: Advancing to term 1
02:11:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.875578 23036 raft_consensus.cc:3060] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 0 FOLLOWER]: Advancing to term 1
02:11:26.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.876688 22901 raft_consensus.cc:2468] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate dd71b671e2204ecbbdd38e191aecab6b in term 1.
02:11:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.876725 23036 raft_consensus.cc:2468] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate dd71b671e2204ecbbdd38e191aecab6b in term 1.
02:11:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.877059 23105 leader_election.cc:304] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [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: 7f8b5f4e7f224892b09dd63857e27926, dd71b671e2204ecbbdd38e191aecab6b; no voters: 
02:11:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.877223 23254 raft_consensus.cc:2804] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 1 FOLLOWER]: Leader election won for term 1
02:11:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.877789 23254 raft_consensus.cc:697] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [term 1 LEADER]: Becoming Leader. State: Replica: dd71b671e2204ecbbdd38e191aecab6b, State: Running, Role: LEADER
02:11:26.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.878266 23254 consensus_queue.cc:237] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [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: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } }
02:11:26.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:26.881897 22720 catalog_manager.cc:5697] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b reported cstate change: term changed from 0 to 1, leader changed from <none> to dd71b671e2204ecbbdd38e191aecab6b (127.22.1.195). New cstate: current_term: 1 leader_uuid: "dd71b671e2204ecbbdd38e191aecab6b" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "dd71b671e2204ecbbdd38e191aecab6b" member_type: VOTER last_known_addr { host: "127.22.1.195" port: 41909 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 } health_report { overall_health: UNKNOWN } } }
02:11:26.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:26.882220 23085 tablet.cc:2406] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:26.946 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 8438821744f74dfdb6f4db4c5fa1e53c for table 'org.apache.kudu.client.TestHybridTime-1783476683972' with partition [<start>, <end>)
02:11:26.953 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=8438821744f74dfdb6f4db4c5fa1e53c@[7f8b5f4e7f224892b09dd63857e27926(127.22.1.194:42005),dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)[L],de31c4db13674e3cad33f4aba936d417(127.22.1.193:41275)]}]
02:11:26.954 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=16), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.22.1.252:41575, [7ms] Sub RPC GetTableLocations: received response from server master-127.22.1.252:41575: OK, deferred=null) after lookup
02:11:26.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:11:26.955953 22950 tablet.cc:2406] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:11:26.964 [DEBUG - kudu-nio-1] (Connection.java:748) [peer dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)] connecting to peer
02:11:26.967 [DEBUG - kudu-nio-3] (Connection.java:757) [peer dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)] Successfully connected to peer
02:11:27.027 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0xee501de1, L:/127.0.0.1:58102 - R:/127.22.1.195:41909] using TOKEN/null
02:11:27.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.033841 22901 raft_consensus.cc:1275] T 8438821744f74dfdb6f4db4c5fa1e53c P de31c4db13674e3cad33f4aba936d417 [term 1 FOLLOWER]: Refusing update from remote peer dd71b671e2204ecbbdd38e191aecab6b: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:27.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.033871 23036 raft_consensus.cc:1275] T 8438821744f74dfdb6f4db4c5fa1e53c P 7f8b5f4e7f224892b09dd63857e27926 [term 1 FOLLOWER]: Refusing update from remote peer dd71b671e2204ecbbdd38e191aecab6b: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:11:27.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.034510 23254 consensus_queue.cc:1048] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [LEADER]: Connected to new peer: Peer: permanent_uuid: "de31c4db13674e3cad33f4aba936d417" member_type: VOTER last_known_addr { host: "127.22.1.193" port: 41275 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:27.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.034651 23257 consensus_queue.cc:1048] T 8438821744f74dfdb6f4db4c5fa1e53c P dd71b671e2204ecbbdd38e191aecab6b [LEADER]: Connected to new peer: Peer: permanent_uuid: "7f8b5f4e7f224892b09dd63857e27926" member_type: VOTER last_known_addr { host: "127.22.1.194" port: 42005 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:11:27.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.048504 23264 mvcc.cc:204] Tried to move back new op lower bound from 7305120510083907584 to 7305120509457293312. Current Snapshot: MvccSnapshot[applied={T|T < 7305120510083907584}]
02:11:27.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.049268 23263 mvcc.cc:204] Tried to move back new op lower bound from 7305120510083907584 to 7305120509457293312. Current Snapshot: MvccSnapshot[applied={T|T < 7305120510083907584}]
02:11:27.082 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.095 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.101 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.105 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1681794698(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:27.116 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.117 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1297210781(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:27.124 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.125 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@239273616(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:27.133 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:27.178 [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-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.185 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305120530563907585) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.190 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305120530563907589) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.194 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305120530563907593) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.197 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305120530563907597) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.201 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305120530563907601) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.205 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305120530563907605) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.209 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305120530563907606) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476683972, tablet=8438821744f74dfdb6f4db4c5fa1e53c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:27.212 [DEBUG - main] (Connection.java:575) [peer master-127.22.1.254:37541(127.22.1.254:37541)] disconnecting while in state READY
02:11:27.219 [DEBUG - main] (Connection.java:575) [peer master-127.22.1.252:41575(127.22.1.252:41575)] disconnecting while in state READY
02:11:27.219 [DEBUG - main] (Connection.java:575) [peer master-127.22.1.253:36971(127.22.1.253:36971)] disconnecting while in state READY
02:11:27.219 [DEBUG - main] (Connection.java:575) [peer dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)] disconnecting while in state READY
02:11:27.225 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.22.1.254:37541(127.22.1.254:37541)] handling channelInactive
02:11:27.226 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.22.1.254:37541(127.22.1.254:37541)] cleaning up while in state READY due to: connection closed
02:11:27.227 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.22.1.253:36971(127.22.1.253:36971)] handling channelInactive
02:11:27.227 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.22.1.253:36971(127.22.1.253:36971)] cleaning up while in state READY due to: connection closed
02:11:27.227 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.22.1.252:41575(127.22.1.252:41575)] handling channelInactive
02:11:27.228 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.22.1.252:41575(127.22.1.252:41575)] cleaning up while in state READY due to: connection closed
02:11:27.232 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
02:11:27.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.240047 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 22819
02:11:27.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.249711 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 22954
02:11:27.259 [DEBUG - kudu-nio-3] (Connection.java:239) [peer dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)] handling channelInactive
02:11:27.260 [DEBUG - kudu-nio-3] (Connection.java:709) [peer dd71b671e2204ecbbdd38e191aecab6b(127.22.1.195:41909)] cleaning up while in state READY due to: connection closed
02:11:27.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.262203 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 23089
02:11:27.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.269495 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 22546
02:11:27.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.279922 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 22615
02:11:27.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:27.292711 22535 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskCOzYhB/build/debug/bin/kudu with pid 22687
02:11:27.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:27Z chronyd exiting

Time: 3.515

OK (1 test)

