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

02:10:55.509 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:10:55.511 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

02:10:55.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.514974  8432 mini_oidc.cc:150] Starting JWKS server
02:10:55.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.520319  8432 webserver.cc:534] Webserver started at http://127.0.0.1:42867/ using document root <none> and password file <none>
02:10:55.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.520804  8432 mini_oidc.cc:186] Starting OIDC Discovery server
02:10:55.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.521639  8432 webserver.cc:534] Webserver started at http://127.0.0.1:40459/ using document root <none> and password file <none>
02:10:55.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:10:55Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
02:10:55.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:10:55Z Disabled control of system clock
02:10:55.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.555152  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:55.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:55.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal
02:10:55.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data
02:10:55.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:55.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:55.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:55.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:55.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:55.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:55.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/logs
02:10:55.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data/info.pb
02:10:55.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:55.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:55.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:55.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:55.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:55.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:55.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:55.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:55.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:10:55.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:55.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:55.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:55.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.62:38165
02:10:55.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.62
02:10:55.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:55.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:55.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:55.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:55.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:55.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:55.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:55.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:55.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json with env {}
02:10:55.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.720429  8443 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:55.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.720710  8443 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:55.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.720762  8443 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:55.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726163  8443 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:10:55.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726266  8443 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:55.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726289  8443 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:10:55.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726308  8443 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:10:55.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726328  8443 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:10:55.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.726343  8443 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42867/jwks.json
02:10:55.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.731714  8443 master_runner.cc:387] Master server non-default flags:
02:10:55.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:55.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:55.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:55.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:55.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data
02:10:55.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal
02:10:55.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:55.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:55.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:55.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:55.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:55.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.62:38165
02:10:55.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:55.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:55.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:55.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json
02:10:55.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:55.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:55.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data/info.pb
02:10:55.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.62
02:10:55.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:55.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:55.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8443
02:10:55.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:55.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:55.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:55.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:55.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/logs
02:10:55.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:55.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:55.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:55.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:55.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.735219  8443 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:55.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.737744  8443 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:55.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.751211  8448 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:10:55.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.751395  8449 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:10:55.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.751881  8451 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:10:55.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.753222  8443 server_base.cc:1061] running on GCE node
02:10:55.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.754513  8443 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:55.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.756384  8443 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:55.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.757989  8443 hybrid_clock.cc:648] HybridClock initialized: now 1783476655757924 us; error 81 us; skew 500 ppm
02:10:55.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.760715  8443 webserver.cc:534] Webserver started at http://127.8.60.62:41401/ using document root <none> and password file <none>
02:10:55.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.762069  8443 fs_manager.cc:362] Metadata directory not provided
02:10:55.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.762193  8443 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:55.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.762764  8443 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:55.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.765894  8443 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data/instance:
02:10:55.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d41460f15f443b4a4687d184d26c4bd"
02:10:55.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:55 on dist-test-slave-nhgm"
02:10:55.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.766849  8443 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal/instance:
02:10:55.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d41460f15f443b4a4687d184d26c4bd"
02:10:55.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:55 on dist-test-slave-nhgm"
02:10:55.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.776074  8443 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.007s	sys 0.000s
02:10:55.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.782183  8457 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:55.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.784780  8443 fs_manager.cc:730] Time spent opening block manager: real 0.006s	user 0.002s	sys 0.000s
02:10:55.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.785080  8443 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal
02:10:55.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3d41460f15f443b4a4687d184d26c4bd"
02:10:55.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:55 on dist-test-slave-nhgm"
02:10:55.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.785295  8443 fs_report.cc:389] FS layout report
02:10:55.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:55.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal
02:10:55.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal
02:10:55.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data/data
02:10:55.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:55.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:55.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:55.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:55.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:55.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:55.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:55.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:55.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:55.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:55.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:55.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.808744  8443 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:55.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.810453  8443 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:55.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.810827  8443 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:55.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.831090  8509 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.62:38165 every 8 connection(s)
02:10:55.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.831413  8443 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.62:38165
02:10:55.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.834229  8443 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/data/info.pb
02:10:55.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.837952  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8443
02:10:55.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.838256  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-0/wal/instance
02:10:55.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.840878  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:55.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:55.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal
02:10:55.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data
02:10:55.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:55.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:55.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:55.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:55.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:55.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:55.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/logs
02:10:55.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data/info.pb
02:10:55.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:55.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:55.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:55.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:55.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:55.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:55.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:55.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:55.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.61:35335
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.61
02:10:55.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:55.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:55.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:55.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:55.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:55.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:55.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:55.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:55.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json with env {}
02:10:55.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.844715  8510 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:10:55.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.853704  8510 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } has no permanent_uuid. Determining permanent_uuid...
02:10:55.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.891631  8510 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } has no permanent_uuid. Determining permanent_uuid...
02:10:55.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.893018  8461 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.60.61:35335: connect: Connection refused (error 111)
02:10:55.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.894150  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.61:35335: Network error: Client connection negotiation failed: client connection to 127.8.60.61:35335: connect: Connection refused (error 111)
02:10:55.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:55.943490  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } attempt: 1
02:10:55.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:55.946748  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.61:35335: Network error: Client connection negotiation failed: client connection to 127.8.60.61:35335: connect: Connection refused (error 111)
02:10:56.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.015286  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } attempt: 2
02:10:56.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.017970  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.61:35335: Network error: Client connection negotiation failed: client connection to 127.8.60.61:35335: connect: Connection refused (error 111)
02:10:56.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.040329  8512 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:56.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.040616  8512 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:56.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.040668  8512 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:56.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.044925  8512 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:10:56.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.045055  8512 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:56.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.045085  8512 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:10:56.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.045104  8512 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:10:56.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.045123  8512 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:10:56.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.045138  8512 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42867/jwks.json
02:10:56.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.053804  8512 master_runner.cc:387] Master server non-default flags:
02:10:56.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:56.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:56.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:56.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:56.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data
02:10:56.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal
02:10:56.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:56.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:56.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:56.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.61:35335
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:56.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data/info.pb
02:10:56.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.61
02:10:56.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:56.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:56.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8512
02:10:56.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/logs
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:56.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:56.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:56.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.056493  8512 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:56.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.059918  8512 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:56.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.069187  8523 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:10:56.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.069187  8520 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:10:56.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.071528  8512 server_base.cc:1061] running on GCE node
02:10:56.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.069867  8521 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:10:56.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.072624  8512 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:56.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.074164  8512 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:56.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.075465  8512 hybrid_clock.cc:648] HybridClock initialized: now 1783476656075343 us; error 151 us; skew 500 ppm
02:10:56.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.078724  8512 webserver.cc:534] Webserver started at http://127.8.60.61:44785/ using document root <none> and password file <none>
02:10:56.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.079613  8512 fs_manager.cc:362] Metadata directory not provided
02:10:56.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.079692  8512 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:56.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.079957  8512 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:56.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.083133  8512 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data/instance:
02:10:56.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "026994bdaaca43bfb2dce583ee2ed193"
02:10:56.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.083971  8512 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal/instance:
02:10:56.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "026994bdaaca43bfb2dce583ee2ed193"
02:10:56.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.090191  8512 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
02:10:56.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.094286  8529 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:56.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.097218  8512 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.000s
02:10:56.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.097437  8512 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal
02:10:56.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "026994bdaaca43bfb2dce583ee2ed193"
02:10:56.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.098223  8512 fs_report.cc:389] FS layout report
02:10:56.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:56.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal
02:10:56.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal
02:10:56.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data/data
02:10:56.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:56.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:56.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.109304  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } attempt: 3
02:10:56.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.113159  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.61:35335: Network error: Client connection negotiation failed: client connection to 127.8.60.61:35335: connect: Connection refused (error 111)
02:10:56.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.125258  8512 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:56.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.126243  8512 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:56.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.126408  8512 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:56.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.140005  8512 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.61:35335
02:10:56.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.139994  8581 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.61:35335 every 8 connection(s)
02:10:56.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.142535  8512 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/data/info.pb
02:10:56.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.146400  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8512
02:10:56.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.146517  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-1/wal/instance
02:10:56.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.147246  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:56.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:56.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:56.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/logs
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data/info.pb
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:56.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:56.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.60:45817
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.60
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:56.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:56.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:56.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:56.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:56.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json with env {}
02:10:56.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.147958  8582 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:10:56.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.153724  8582 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.173847  8582 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.183296  8582 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.184542  8532 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.186251  8582 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.236135  8582 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 1
02:10:56.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.239593  8582 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.256439  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } attempt: 4
02:10:56.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.263586  8510 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.265705  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.307902  8582 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 2
02:10:56.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.310851  8582 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.324930  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 1
02:10:56.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.327066  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.327993  8584 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:56.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.328259  8584 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:56.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.328315  8584 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:56.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.332883  8584 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:10:56.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.332993  8584 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:56.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.333019  8584 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:10:56.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.333038  8584 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:10:56.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.333062  8584 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:10:56.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.333081  8584 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:42867/jwks.json
02:10:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.340124  8584 master_runner.cc:387] Master server non-default flags:
02:10:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:10:56.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:56.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:56.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:56.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.60:45817
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42867/jwks.json
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data/info.pb
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.60
02:10:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8584
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/logs
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:56.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:56.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:56.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:56.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:56.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.342001  8584 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:56.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.343379  8584 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:56.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.352278  8595 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:10:56.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.352439  8593 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:10:56.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.352308  8592 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:10:56.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.353448  8584 server_base.cc:1061] running on GCE node
02:10:56.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.354835  8584 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:56.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.356383  8584 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:56.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.357683  8584 hybrid_clock.cc:648] HybridClock initialized: now 1783476656357619 us; error 98 us; skew 500 ppm
02:10:56.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.360975  8584 webserver.cc:534] Webserver started at http://127.8.60.60:39121/ using document root <none> and password file <none>
02:10:56.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.362257  8584 fs_manager.cc:362] Metadata directory not provided
02:10:56.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.362455  8584 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:56.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.362884  8584 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:56.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.365772  8584 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data/instance:
02:10:56.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "80b8e956cb154fce9184f67686b19b61"
02:10:56.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.366634  8584 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal/instance:
02:10:56.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "80b8e956cb154fce9184f67686b19b61"
02:10:56.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.371742  8584 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.001s
02:10:56.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.375627  8601 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.377039  8584 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.000s	sys 0.004s
02:10:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.377218  8584 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal
02:10:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "80b8e956cb154fce9184f67686b19b61"
02:10:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:56 on dist-test-slave-nhgm"
02:10:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.377362  8584 fs_report.cc:389] FS layout report
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data/data
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:56.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.394369  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 2
02:10:56.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.396756  8510 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.400887  8584 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:56.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.402065  8584 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:56.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.402344  8584 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:56.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.402119  8582 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 3
02:10:56.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.404812  8582 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.60.60:45817: Network error: Client connection negotiation failed: client connection to 127.8.60.60:45817: connect: Connection refused (error 111)
02:10:56.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.416896  8653 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.60:45817 every 8 connection(s)
02:10:56.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.417004  8584 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.60:45817
02:10:56.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.419230  8584 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/data/info.pb
02:10:56.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.422897  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8584
02:10:56.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.423053  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/master-2/wal/instance
02:10:56.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.424042  8654 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:10:56.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.429404  8654 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.446818  8654 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.452786  8654 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } has no permanent_uuid. Determining permanent_uuid...
02:10:56.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.467547  8654 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: Bootstrap starting.
02:10:56.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.473153  8654 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: Neither blocks nor log segments found. Creating new log.
02:10:56.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.474360  8654 log.cc:826] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: Log is configured to *not* fsync() on all Append() calls
02:10:56.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.477123  8654 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: No bootstrap required, opened a new log
02:10:56.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.481142  8654 raft_consensus.cc:359] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.482167  8654 raft_consensus.cc:385] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:56.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.482306  8654 raft_consensus.cc:740] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 80b8e956cb154fce9184f67686b19b61, State: Initialized, Role: FOLLOWER
02:10:56.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.483188  8654 consensus_queue.cc:260] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.484186  8661 sys_catalog.cc:455] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.484385  8661 sys_catalog.cc:458] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.485370  8654 sys_catalog.cc:565] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: configured and running, proceeding with master startup.
02:10:56.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.493237  8584 master_runner.cc:187] Error getting master registration for 127.8.60.62:38165: OK, instance_id { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" instance_seqno: 1783476655825565 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:10:56.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.496089  8584 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:10:56.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.496960  8672 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:10:56.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.497066  8672 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:10:56.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.497115  8510 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 3
02:10:56.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.507126  8510 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: Bootstrap starting.
02:10:56.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.510385  8510 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: Neither blocks nor log segments found. Creating new log.
02:10:56.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.511448  8510 log.cc:826] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: Log is configured to *not* fsync() on all Append() calls
02:10:56.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.513953  8510 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: No bootstrap required, opened a new log
02:10:56.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.517055  8510 raft_consensus.cc:359] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.517251  8510 raft_consensus.cc:385] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:56.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.517287  8510 raft_consensus.cc:740] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3d41460f15f443b4a4687d184d26c4bd, State: Initialized, Role: FOLLOWER
02:10:56.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.517755  8510 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.518253  8675 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.518378  8675 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.519079  8510 sys_catalog.cc:565] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: configured and running, proceeding with master startup.
02:10:56.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.524785  8686 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:10:56.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.524917  8686 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:10:56.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.527424  8443 master_runner.cc:187] Error getting master registration for 127.8.60.61:35335: OK, instance_id { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" instance_seqno: 1783476656135748 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:10:56.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.530639  8443 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:10:56.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.548233  8582 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } attempt: 4
02:10:56.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.558928  8582 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: Bootstrap starting.
02:10:56.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.562444  8582 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: Neither blocks nor log segments found. Creating new log.
02:10:56.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.563477  8582 log.cc:826] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: Log is configured to *not* fsync() on all Append() calls
02:10:56.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.564577  8463 tablet.cc:2406] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:56.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.566664  8582 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: No bootstrap required, opened a new log
02:10:56.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.570725  8582 raft_consensus.cc:359] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.572027  8582 raft_consensus.cc:385] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:56.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.572595  8582 raft_consensus.cc:740] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 026994bdaaca43bfb2dce583ee2ed193, State: Initialized, Role: FOLLOWER
02:10:56.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.573549  8582 consensus_queue.cc:260] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.574944  8689 sys_catalog.cc:455] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.575397  8689 sys_catalog.cc:458] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.575592  8582 sys_catalog.cc:565] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: configured and running, proceeding with master startup.
02:10:56.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.586799  8700 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:10:56.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.587738  8700 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:10:56.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.594861  8512 master_runner.cc:264] No leader master found from master 026994bdaaca43bfb2dce583ee2ed193
02:10:56.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.595003  8512 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:10:56.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.628845  8535 tablet.cc:2406] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:56.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:56.654966  8607 tablet.cc:2406] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:56.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.698684  8675 raft_consensus.cc:493] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:10:56.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.699009  8675 raft_consensus.cc:515] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.700975  8675 leader_election.cc:290] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 026994bdaaca43bfb2dce583ee2ed193 (127.8.60.61:35335), 80b8e956cb154fce9184f67686b19b61 (127.8.60.60:45817)
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.703253  8689 raft_consensus.cc:493] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.703446  8689 raft_consensus.cc:515] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.703431  8628 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3d41460f15f443b4a4687d184d26c4bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "80b8e956cb154fce9184f67686b19b61" is_pre_election: true
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.703830  8628 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3d41460f15f443b4a4687d184d26c4bd in term 0.
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.704593  8689 leader_election.cc:290] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3d41460f15f443b4a4687d184d26c4bd (127.8.60.62:38165), 80b8e956cb154fce9184f67686b19b61 (127.8.60.60:45817)
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.704644  8555 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "3d41460f15f443b4a4687d184d26c4bd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "026994bdaaca43bfb2dce583ee2ed193" is_pre_election: true
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.704849  8555 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3d41460f15f443b4a4687d184d26c4bd in term 0.
02:10:56.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.705582  8461 leader_election.cc:304] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [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: 026994bdaaca43bfb2dce583ee2ed193, 3d41460f15f443b4a4687d184d26c4bd; no voters: 
02:10:56.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.709064  8628 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "026994bdaaca43bfb2dce583ee2ed193" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "80b8e956cb154fce9184f67686b19b61" is_pre_election: true
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.709270  8628 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 026994bdaaca43bfb2dce583ee2ed193 in term 0.
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.709923  8532 leader_election.cc:304] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [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: 026994bdaaca43bfb2dce583ee2ed193, 80b8e956cb154fce9184f67686b19b61; no voters: 
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.710355  8689 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Leader pre-election won for term 1
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.710428  8689 raft_consensus.cc:493] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.710470  8689 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 0 FOLLOWER]: Advancing to term 1
02:10:56.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.712054  8689 raft_consensus.cc:515] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.712605  8689 leader_election.cc:290] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [CANDIDATE]: Term 1 election: Requested vote from peers 3d41460f15f443b4a4687d184d26c4bd (127.8.60.62:38165), 80b8e956cb154fce9184f67686b19b61 (127.8.60.60:45817)
02:10:56.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.714170  8483 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "026994bdaaca43bfb2dce583ee2ed193" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3d41460f15f443b4a4687d184d26c4bd" is_pre_election: true
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.714458  8483 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 026994bdaaca43bfb2dce583ee2ed193 in term 0.
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.714705  8484 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "026994bdaaca43bfb2dce583ee2ed193" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3d41460f15f443b4a4687d184d26c4bd"
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.714811  8484 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 0 FOLLOWER]: Advancing to term 1
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.716291  8484 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 026994bdaaca43bfb2dce583ee2ed193 in term 1.
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.716976  8532 leader_election.cc:304] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [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: 026994bdaaca43bfb2dce583ee2ed193, 3d41460f15f443b4a4687d184d26c4bd; no voters: 
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.717567  8628 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "026994bdaaca43bfb2dce583ee2ed193" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "80b8e956cb154fce9184f67686b19b61"
02:10:56.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.717729  8628 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 0 FOLLOWER]: Advancing to term 1
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.719885  8628 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 026994bdaaca43bfb2dce583ee2ed193 in term 1.
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.722151  8689 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 1 FOLLOWER]: Leader election won for term 1
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.722476  8689 raft_consensus.cc:697] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [term 1 LEADER]: Becoming Leader. State: Replica: 026994bdaaca43bfb2dce583ee2ed193, State: Running, Role: LEADER
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.722719  8675 raft_consensus.cc:2764] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 1 FOLLOWER]: Leader pre-election decision vote started in defunct term 0: won
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.723394  8689 consensus_queue.cc:237] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [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: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } }
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.729060  8689 sys_catalog.cc:455] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 026994bdaaca43bfb2dce583ee2ed193. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.729220  8689 sys_catalog.cc:458] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: This master's current role is: LEADER
02:10:56.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.747306  8704 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
02:10:56.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.749428  8704 catalog_manager.cc:1519] Initializing Kudu cluster ID...
02:10:56.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.769215  8628 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [term 1 FOLLOWER]: Refusing update from remote peer 026994bdaaca43bfb2dce583ee2ed193: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:10:56.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.772774  8702 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [LEADER]: Connected to new peer: Peer: permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:10:56.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.781670  8661 sys_catalog.cc:455] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 026994bdaaca43bfb2dce583ee2ed193. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.781869  8661 sys_catalog.cc:458] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.788400  8483 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [term 1 FOLLOWER]: Refusing update from remote peer 026994bdaaca43bfb2dce583ee2ed193: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:10:56.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.792328  8702 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [LEADER]: Connected to new peer: Peer: permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:10:56.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.800498  8675 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: SysCatalogTable state changed. Reason: New leader 026994bdaaca43bfb2dce583ee2ed193. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.800974  8675 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.809329  8675 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.809510  8675 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.810910  8702 sys_catalog.cc:455] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.811064  8702 sys_catalog.cc:458] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: This master's current role is: LEADER
02:10:56.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.814050  8705 mvcc.cc:204] Tried to move back new op lower bound from 7305120386111549440 to 7305120385955651584. Current Snapshot: MvccSnapshot[applied={T|T < 7305120386111549440}]
02:10:56.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.821416  8708 mvcc.cc:204] Tried to move back new op lower bound from 7305120386111549440 to 7305120385955651584. Current Snapshot: MvccSnapshot[applied={T|T < 7305120386111549440}]
02:10:56.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.822804  8689 sys_catalog.cc:455] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.822956  8689 sys_catalog.cc:458] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193 [sys.catalog]: This master's current role is: LEADER
02:10:56.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.824684  8661 sys_catalog.cc:455] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "026994bdaaca43bfb2dce583ee2ed193" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3d41460f15f443b4a4687d184d26c4bd" member_type: VOTER last_known_addr { host: "127.8.60.62" port: 38165 } } peers { permanent_uuid: "026994bdaaca43bfb2dce583ee2ed193" member_type: VOTER last_known_addr { host: "127.8.60.61" port: 35335 } } peers { permanent_uuid: "80b8e956cb154fce9184f67686b19b61" member_type: VOTER last_known_addr { host: "127.8.60.60" port: 45817 } } }
02:10:56.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.824842  8661 sys_catalog.cc:458] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61 [sys.catalog]: This master's current role is: FOLLOWER
02:10:56.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.828047  8706 mvcc.cc:204] Tried to move back new op lower bound from 7305120386111549440 to 7305120385955651584. Current Snapshot: MvccSnapshot[applied={T|T < 7305120386111549440}]
02:10:56.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.850756  8704 catalog_manager.cc:1382] Generated new cluster ID: 06acf65442e441de8a100df4f5f88046
02:10:56.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.850865  8704 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
02:10:56.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.875442  8704 catalog_manager.cc:1405] Generated new certificate authority record
02:10:56.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.877799  8704 catalog_manager.cc:1539] Loading token signing keys...
02:10:56.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.890375  8704 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 026994bdaaca43bfb2dce583ee2ed193: Generated new TSK 0
02:10:56.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.892179  8704 catalog_manager.cc:1549] Initializing in-progress tserver states...
02:10:56.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:56.909924  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:56.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/logs
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data/info.pb
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.1:0
02:10:56.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.1
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.1
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:56.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:10:57.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.073050  8714 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:57.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.073385  8714 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:57.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.073442  8714 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:57.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.078186  8714 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:57.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.078341  8714 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.60.1
02:10:57.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.087570  8714 tablet_server_runner.cc:78] Tablet server non-default flags:
02:10:57.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:57.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.1:0
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data/info.pb
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.1
02:10:57.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:57.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:57.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:57.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8714
02:10:57.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:57.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.1
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/logs
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:57.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:57.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:57.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.089973  8714 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:57.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.091889  8714 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:57.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.104331  8720 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:10:57.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.104331  8719 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:10:57.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.104879  8722 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:10:57.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.105015  8714 server_base.cc:1061] running on GCE node
02:10:57.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.105680  8714 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:57.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.106549  8714 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:57.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.108018  8714 hybrid_clock.cc:648] HybridClock initialized: now 1783476657107970 us; error 52 us; skew 500 ppm
02:10:57.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.111231  8714 webserver.cc:534] Webserver started at http://127.8.60.1:34297/ using document root <none> and password file <none>
02:10:57.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.111910  8714 fs_manager.cc:362] Metadata directory not provided
02:10:57.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.111963  8714 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:57.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.112178  8714 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:57.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.114377  8714 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data/instance:
02:10:57.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c"
02:10:57.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.115005  8714 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal/instance:
02:10:57.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c"
02:10:57.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.120452  8714 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.000s
02:10:57.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.124099  8728 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:57.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.125756  8714 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.125921  8714 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c"
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.126048  8714 fs_report.cc:389] FS layout report
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data/data
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:57.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:57.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:57.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.146731  8714 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:57.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.147799  8714 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:57.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.148110  8714 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:57.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.149842  8714 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:10:57.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.151777  8714 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:10:57.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.151856  8714 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:10:57.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.151911  8714 ts_tablet_manager.cc:616] Registered 0 tablets
02:10:57.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.151928  8714 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:10:57.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.169179  8714 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.1:38569
02:10:57.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.169317  8841 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.1:38569 every 8 connection(s)
02:10:57.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.171263  8714 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/data/info.pb
02:10:57.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.172156  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8714
02:10:57.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.172307  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-0/wal/instance
02:10:57.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.176360  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:57.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:57.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/logs
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data/info.pb
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:57.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.2:0
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.2
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.2
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:57.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:10:57.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.190546  8842 heartbeater.cc:344] Connected to a master server at 127.8.60.60:45817
02:10:57.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.190465  8844 heartbeater.cc:344] Connected to a master server at 127.8.60.61:35335
02:10:57.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.191180  8844 heartbeater.cc:461] Registering TS with master...
02:10:57.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.191243  8843 heartbeater.cc:344] Connected to a master server at 127.8.60.62:38165
02:10:57.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.191579  8843 heartbeater.cc:461] Registering TS with master...
02:10:57.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.191180  8842 heartbeater.cc:461] Registering TS with master...
02:10:57.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.192481  8842 heartbeater.cc:507] Master 127.8.60.60:45817 requested a full tablet report, sending...
02:10:57.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.192481  8844 heartbeater.cc:507] Master 127.8.60.61:35335 requested a full tablet report, sending...
02:10:57.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.193774  8843 heartbeater.cc:507] Master 127.8.60.62:38165 requested a full tablet report, sending...
02:10:57.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.195953  8473 ts_manager.cc:194] Registered new tserver with Master: 9c0fc7d6eac24c599ac0e07d1ffb058c (127.8.60.1:38569)
02:10:57.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.195955  8546 ts_manager.cc:194] Registered new tserver with Master: 9c0fc7d6eac24c599ac0e07d1ffb058c (127.8.60.1:38569)
02:10:57.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.196630  8618 ts_manager.cc:194] Registered new tserver with Master: 9c0fc7d6eac24c599ac0e07d1ffb058c (127.8.60.1:38569)
02:10:57.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.199415  8546 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.60.1:40007
02:10:57.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.346665  8852 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:57.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.346927  8852 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:57.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.346973  8852 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:57.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.350543  8852 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:57.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.350699  8852 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.60.2
02:10:57.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.355062  8852 tablet_server_runner.cc:78] Tablet server non-default flags:
02:10:57.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:57.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.2:0
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data/info.pb
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.2
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8852
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:57.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.2
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/logs
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:57.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.357290  8852 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:57.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.359483  8852 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:57.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.368566  8858 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:10:57.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.368597  8860 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:10:57.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.368516  8857 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:10:57.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.369323  8852 server_base.cc:1061] running on GCE node
02:10:57.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.369830  8852 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:57.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.370533  8852 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:57.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.373976  8852 hybrid_clock.cc:648] HybridClock initialized: now 1783476657373893 us; error 125 us; skew 500 ppm
02:10:57.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.376549  8852 webserver.cc:534] Webserver started at http://127.8.60.2:39493/ using document root <none> and password file <none>
02:10:57.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.377429  8852 fs_manager.cc:362] Metadata directory not provided
02:10:57.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.377535  8852 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:57.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.377862  8852 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.380646  8852 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data/instance:
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a86e53b6263049d79801dd246c58d460"
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.381479  8852 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal/instance:
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a86e53b6263049d79801dd246c58d460"
02:10:57.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.388558  8852 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.003s
02:10:57.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.392885  8866 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.394781  8852 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.000s
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.394958  8852 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a86e53b6263049d79801dd246c58d460"
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.395107  8852 fs_report.cc:389] FS layout report
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal
02:10:57.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data/data
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:57.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:57.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.442101  8852 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:57.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.443102  8852 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:57.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.443367  8852 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:57.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.444242  8852 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:10:57.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.446851  8852 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:10:57.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.446979  8852 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:10:57.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.447248  8852 ts_tablet_manager.cc:616] Registered 0 tablets
02:10:57.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.447315  8852 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:10:57.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.463125  8852 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.2:39043
02:10:57.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.463191  8979 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.2:39043 every 8 connection(s)
02:10:57.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.464828  8852 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/data/info.pb
02:10:57.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.471678  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8852
02:10:57.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.471804  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-1/wal/instance
02:10:57.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.477212  8432 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/logs
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data/info.pb
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:57.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.3:0
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.3
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.3
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:57.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.478477  8980 heartbeater.cc:344] Connected to a master server at 127.8.60.60:45817
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.479030  8980 heartbeater.cc:461] Registering TS with master...
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.479575  8981 heartbeater.cc:344] Connected to a master server at 127.8.60.62:38165
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.479674  8981 heartbeater.cc:461] Registering TS with master...
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.480261  8980 heartbeater.cc:507] Master 127.8.60.60:45817 requested a full tablet report, sending...
02:10:57.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.480258  8981 heartbeater.cc:507] Master 127.8.60.62:38165 requested a full tablet report, sending...
02:10:57.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.483346  8618 ts_manager.cc:194] Registered new tserver with Master: a86e53b6263049d79801dd246c58d460 (127.8.60.2:39043)
02:10:57.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.483392  8473 ts_manager.cc:194] Registered new tserver with Master: a86e53b6263049d79801dd246c58d460 (127.8.60.2:39043)
02:10:57.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.484001  8982 heartbeater.cc:344] Connected to a master server at 127.8.60.61:35335
02:10:57.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.484099  8982 heartbeater.cc:461] Registering TS with master...
02:10:57.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.484354  8982 heartbeater.cc:507] Master 127.8.60.61:35335 requested a full tablet report, sending...
02:10:57.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.485736  8546 ts_manager.cc:194] Registered new tserver with Master: a86e53b6263049d79801dd246c58d460 (127.8.60.2:39043)
02:10:57.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.486793  8546 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.60.2:51555
02:10:57.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.499961  8672 catalog_manager.cc:1294] Loaded cluster ID: 06acf65442e441de8a100df4f5f88046
02:10:57.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.500097  8672 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: loading cluster ID for follower catalog manager: success
02:10:57.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.502416  8672 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: acquiring CA information for follower catalog manager: success
02:10:57.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.505226  8672 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 80b8e956cb154fce9184f67686b19b61: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:10:57.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.526496  8686 catalog_manager.cc:1294] Loaded cluster ID: 06acf65442e441de8a100df4f5f88046
02:10:57.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.526646  8686 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: loading cluster ID for follower catalog manager: success
02:10:57.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.529680  8686 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: acquiring CA information for follower catalog manager: success
02:10:57.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.531390  8686 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 3d41460f15f443b4a4687d184d26c4bd: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:10:57.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.655265  8987 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:10:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.655546  8987 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:10:57.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.655593  8987 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:10:57.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.661708  8987 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:10:57.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.662204  8987 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.60.3
02:10:57.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.669239  8987 tablet_server_runner.cc:78] Tablet server non-default flags:
02:10:57.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.60.20:42709
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.60.3:0
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data/info.pb
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.60.3
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.60.62:38165,127.8.60.61:35335,127.8.60.60:45817
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8987
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:10:57.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:10:57.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.60.3
02:10:57.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/logs
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:33 UTC on bdcb31816ec0
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16847
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.670775  8987 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:10:57.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.672350  8987 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:10:57.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.687458  8995 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:10:57.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.687529  8992 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:10:57.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:57.687522  8993 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:10:57.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.688004  8987 server_base.cc:1061] running on GCE node
02:10:57.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.688930  8987 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:10:57.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.690142  8987 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:10:57.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.693564  8987 hybrid_clock.cc:648] HybridClock initialized: now 1783476657693513 us; error 92 us; skew 500 ppm
02:10:57.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.696868  8987 webserver.cc:534] Webserver started at http://127.8.60.3:37731/ using document root <none> and password file <none>
02:10:57.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.697715  8987 fs_manager.cc:362] Metadata directory not provided
02:10:57.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.697791  8987 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:10:57.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.697994  8987 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:10:57.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.701896  8987 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data/instance:
02:10:57.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813ce93995b54f72ba933a61ff091c52"
02:10:57.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.703297  8987 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal/instance:
02:10:57.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813ce93995b54f72ba933a61ff091c52"
02:10:57.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.709468  8987 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.002s	sys 0.003s
02:10:57.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.712937  9001 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:10:57.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.715972  8987 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.000s
02:10:57.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.716235  8987 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data,/tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal
02:10:57.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "813ce93995b54f72ba933a61ff091c52"
02:10:57.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:10:57 on dist-test-slave-nhgm"
02:10:57.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.716431  8987 fs_report.cc:389] FS layout report
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data/data
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:10:57.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:10:57.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.744958  8987 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:10:57.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.745811  8987 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:10:57.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.746337  8987 kserver.cc:163] Server-wide thread pool size limit: 3276
02:10:57.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.747709  8987 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:10:57.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.749750  8987 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:10:57.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.749954  8987 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:10:57.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.750044  8987 ts_tablet_manager.cc:616] Registered 0 tablets
02:10:57.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.750072  8987 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:10:57.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.764048  8987 rpc_server.cc:307] RPC server started. Bound to: 127.8.60.3:40527
02:10:57.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.764079  9114 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.60.3:40527 every 8 connection(s)
02:10:57.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.765684  8987 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/data/info.pb
02:10:57.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.766608  8432 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu as pid 8987
02:10:57.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.766744  8432 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskVVPWlf/test-tmp/mini-kudu-cluster6829646558288310320/ts-2/wal/instance
02:10:57.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.780359  9115 heartbeater.cc:344] Connected to a master server at 127.8.60.60:45817
02:10:57.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.780524  9116 heartbeater.cc:344] Connected to a master server at 127.8.60.62:38165
02:10:57.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.780741  9115 heartbeater.cc:461] Registering TS with master...
02:10:57.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.780743  9116 heartbeater.cc:461] Registering TS with master...
02:10:57.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.781530  9116 heartbeater.cc:507] Master 127.8.60.62:38165 requested a full tablet report, sending...
02:10:57.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.781530  9115 heartbeater.cc:507] Master 127.8.60.60:45817 requested a full tablet report, sending...
02:10:57.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.781802  9117 heartbeater.cc:344] Connected to a master server at 127.8.60.61:35335
02:10:57.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.782222  9117 heartbeater.cc:461] Registering TS with master...
02:10:57.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.782650  9117 heartbeater.cc:507] Master 127.8.60.61:35335 requested a full tablet report, sending...
02:10:57.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.783468  8473 ts_manager.cc:194] Registered new tserver with Master: 813ce93995b54f72ba933a61ff091c52 (127.8.60.3:40527)
02:10:57.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.783855  8618 ts_manager.cc:194] Registered new tserver with Master: 813ce93995b54f72ba933a61ff091c52 (127.8.60.3:40527)
02:10:57.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.783876  8546 ts_manager.cc:194] Registered new tserver with Master: 813ce93995b54f72ba933a61ff091c52 (127.8.60.3:40527)
02:10:57.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.784770  8546 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.60.3:46769
02:10:57.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:57.801273  8432 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
02:10:57.802 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:10:57.804 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

02:10:57.818 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.60.62"
      port: 38165
    }
    bound_http_address {
      host: "127.8.60.62"
      port: 41401
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.60.61"
      port: 35335
    }
    bound_http_address {
      host: "127.8.60.61"
      port: 44785
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.60.60"
      port: 45817
    }
    bound_http_address {
      host: "127.8.60.60"
      port: 39121
    }
  }
}

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

02:10:57.827 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.60.1"
      port: 38569
    }
    bound_http_address {
      host: "127.8.60.1"
      port: 34297
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.60.2"
      port: 39043
    }
    bound_http_address {
      host: "127.8.60.2"
      port: 39493
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.60.3"
      port: 40527
    }
    bound_http_address {
      host: "127.8.60.3"
      port: 37731
    }
  }
}

02:10:57.827 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
02:10:58.122 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
02:10:58.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:58.202455  8844 heartbeater.cc:499] Master 127.8.60.61:35335 was elected leader, sending a full tablet report...
02:10:58.227 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
02:10:58.457 [DEBUG - main] (Connection.java:748) [peer master-127.8.60.62:38165(127.8.60.62:38165)] connecting to peer
02:10:58.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:58.490834  8982 heartbeater.cc:499] Master 127.8.60.61:35335 was elected leader, sending a full tablet report...
02:10:58.540 [DEBUG - main] (Connection.java:748) [peer master-127.8.60.61:35335(127.8.60.61:35335)] connecting to peer
02:10:58.551 [DEBUG - main] (Connection.java:748) [peer master-127.8.60.60:45817(127.8.60.60:45817)] connecting to peer
02:10:58.567 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.8.60.62:38165(127.8.60.62:38165)] Successfully connected to peer
02:10:58.567 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.8.60.61:35335(127.8.60.61:35335)] Successfully connected to peer
02:10:58.567 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.8.60.60:45817(127.8.60.60:45817)] Successfully connected to peer
02:10:58.712 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.60.60
02:10:58.712 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.60.61
02:10:58.715 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.60.62
02:10:58.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:58.787153  9117 heartbeater.cc:499] Master 127.8.60.61:35335 was elected leader, sending a full tablet report...
02:10:59.063 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xb797bcb4, L:/127.0.0.1:44806 - R:/127.8.60.62:38165] using SASL/PLAIN
02:10:59.063 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x11f14ba6, L:/127.0.0.1:58850 - R:/127.8.60.61:35335] using SASL/PLAIN
02:10:59.063 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x764d3299, L:/127.0.0.1:58512 - R:/127.8.60.60:45817] using SASL/PLAIN
02:10:59.114 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
02:10:59.115 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=720), Traces: [0ms] refreshing cache from master, [31ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.60.62:38165, [127ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.60.61:35335, [138ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.60.60:45817, [673ms] Sub RPC ConnectToMaster: received response from server master-127.8.60.60:45817: OK, [673ms] Sub RPC ConnectToMaster: received response from server master-127.8.60.62:38165: OK, [673ms] Sub RPC ConnectToMaster: received response from server master-127.8.60.61:35335: OK, deferred=null) after lookup
02:10:59.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.192584  8546 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:58850:
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783476654765"
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
02:10:59.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
02:10:59.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
02:10:59.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
02:10:59.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:10:59.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:10:59.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:59.196282  8546 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783476654765 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
02:10:59.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.238184  8776 tablet_service.cc:1511] Processing CreateTablet for tablet 26756b0c3d134805b8f4bfa0e550ee84 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476654765 [id=85de32e522834f6eabcf9fe73e679349]), partition=RANGE (key) PARTITION UNBOUNDED
02:10:59.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.243420  8914 tablet_service.cc:1511] Processing CreateTablet for tablet 26756b0c3d134805b8f4bfa0e550ee84 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476654765 [id=85de32e522834f6eabcf9fe73e679349]), partition=RANGE (key) PARTITION UNBOUNDED
02:10:59.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.233270  9049 tablet_service.cc:1511] Processing CreateTablet for tablet 26756b0c3d134805b8f4bfa0e550ee84 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476654765 [id=85de32e522834f6eabcf9fe73e679349]), partition=RANGE (key) PARTITION UNBOUNDED
02:10:59.245 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 85de32e522834f6eabcf9fe73e679349
02:10:59.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.245380  9049 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 26756b0c3d134805b8f4bfa0e550ee84. 1 dirs total, 0 dirs full, 0 dirs failed
02:10:59.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.245378  8776 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 26756b0c3d134805b8f4bfa0e550ee84. 1 dirs total, 0 dirs full, 0 dirs failed
02:10:59.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.253752  9147 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Bootstrap starting.
02:10:59.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.255735  8914 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 26756b0c3d134805b8f4bfa0e550ee84. 1 dirs total, 0 dirs full, 0 dirs failed
02:10:59.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.258852  9147 tablet_bootstrap.cc:654] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Neither blocks nor log segments found. Creating new log.
02:10:59.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.260569  9147 log.cc:826] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Log is configured to *not* fsync() on all Append() calls
02:10:59.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.263243  9148 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Bootstrap starting.
02:10:59.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.267154  9148 tablet_bootstrap.cc:654] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Neither blocks nor log segments found. Creating new log.
02:10:59.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.267210  9150 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Bootstrap starting.
02:10:59.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.268476  9148 log.cc:826] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Log is configured to *not* fsync() on all Append() calls
02:10:59.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.269832  9147 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: No bootstrap required, opened a new log
02:10:59.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.270673  9150 tablet_bootstrap.cc:654] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Neither blocks nor log segments found. Creating new log.
02:10:59.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.271613  9147 ts_tablet_manager.cc:1403] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Time spent bootstrapping tablet: real 0.018s	user 0.003s	sys 0.006s
02:10:59.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.271826  9150 log.cc:826] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Log is configured to *not* fsync() on all Append() calls
02:10:59.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.282241  9150 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: No bootstrap required, opened a new log
02:10:59.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.282606  9150 ts_tablet_manager.cc:1403] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Time spent bootstrapping tablet: real 0.016s	user 0.006s	sys 0.003s
02:10:59.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.287609  9150 raft_consensus.cc:359] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.287940  9150 raft_consensus.cc:385] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:59.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.288012  9150 raft_consensus.cc:740] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a86e53b6263049d79801dd246c58d460, State: Initialized, Role: FOLLOWER
02:10:59.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.291684  9147 raft_consensus.cc:359] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.293221  9147 raft_consensus.cc:385] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:59.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.289819  9150 consensus_queue.cc:260] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [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: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.294746  9147 raft_consensus.cc:740] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9c0fc7d6eac24c599ac0e07d1ffb058c, State: Initialized, Role: FOLLOWER
02:10:59.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.296844  9148 tablet_bootstrap.cc:492] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: No bootstrap required, opened a new log
02:10:59.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.296804  9150 ts_tablet_manager.cc:1434] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Time spent starting tablet: real 0.014s	user 0.004s	sys 0.004s
02:10:59.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.297130  9148 ts_tablet_manager.cc:1403] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Time spent bootstrapping tablet: real 0.034s	user 0.000s	sys 0.006s
02:10:59.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.296746  9147 consensus_queue.cc:260] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [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: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.300560  9147 ts_tablet_manager.cc:1434] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Time spent starting tablet: real 0.028s	user 0.011s	sys 0.004s
02:10:59.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.302950  9148 raft_consensus.cc:359] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.303267  9148 raft_consensus.cc:385] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:10:59.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.303339  9148 raft_consensus.cc:740] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 813ce93995b54f72ba933a61ff091c52, State: Initialized, Role: FOLLOWER
02:10:59.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.307444  9148 consensus_queue.cc:260] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [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: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.310916  9148 ts_tablet_manager.cc:1434] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Time spent starting tablet: real 0.014s	user 0.010s	sys 0.000s
02:10:59.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:59.427161  8845 tablet.cc:2406] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:59.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:59.474064  8983 tablet.cc:2406] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:59.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:10:59.520810  9118 tablet.cc:2406] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:10:59.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.561733  9154 raft_consensus.cc:493] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:10:59.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.561940  9154 raft_consensus.cc:515] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.563190  9154 leader_election.cc:290] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers a86e53b6263049d79801dd246c58d460 (127.8.60.2:39043), 813ce93995b54f72ba933a61ff091c52 (127.8.60.3:40527)
02:10:59.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.569140  8933 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "26756b0c3d134805b8f4bfa0e550ee84" candidate_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a86e53b6263049d79801dd246c58d460" is_pre_election: true
02:10:59.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.569562  8933 raft_consensus.cc:2468] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 9c0fc7d6eac24c599ac0e07d1ffb058c in term 0.
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570163  8729 leader_election.cc:304] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [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: 9c0fc7d6eac24c599ac0e07d1ffb058c, a86e53b6263049d79801dd246c58d460; no voters: 
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570264  9068 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "26756b0c3d134805b8f4bfa0e550ee84" candidate_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "813ce93995b54f72ba933a61ff091c52" is_pre_election: true
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570501  9154 raft_consensus.cc:2804] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Leader pre-election won for term 1
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570600  9154 raft_consensus.cc:493] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570659  9154 raft_consensus.cc:3060] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 0 FOLLOWER]: Advancing to term 1
02:10:59.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.570641  9068 raft_consensus.cc:2468] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 9c0fc7d6eac24c599ac0e07d1ffb058c in term 0.
02:10:59.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.572100  9154 raft_consensus.cc:515] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.572634  9154 leader_election.cc:290] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [CANDIDATE]: Term 1 election: Requested vote from peers a86e53b6263049d79801dd246c58d460 (127.8.60.2:39043), 813ce93995b54f72ba933a61ff091c52 (127.8.60.3:40527)
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.573266  9068 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "26756b0c3d134805b8f4bfa0e550ee84" candidate_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "813ce93995b54f72ba933a61ff091c52"
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.573405  9068 raft_consensus.cc:3060] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 0 FOLLOWER]: Advancing to term 1
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.573576  8933 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "26756b0c3d134805b8f4bfa0e550ee84" candidate_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a86e53b6263049d79801dd246c58d460"
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.573729  8933 raft_consensus.cc:3060] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 0 FOLLOWER]: Advancing to term 1
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.574954  9068 raft_consensus.cc:2468] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 9c0fc7d6eac24c599ac0e07d1ffb058c in term 1.
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.575531  8933 raft_consensus.cc:2468] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 9c0fc7d6eac24c599ac0e07d1ffb058c in term 1.
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.575932  8729 leader_election.cc:304] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [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: 813ce93995b54f72ba933a61ff091c52, 9c0fc7d6eac24c599ac0e07d1ffb058c; no voters: 
02:10:59.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.576363  9154 raft_consensus.cc:2804] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 1 FOLLOWER]: Leader election won for term 1
02:10:59.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.576815  9154 raft_consensus.cc:697] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [term 1 LEADER]: Becoming Leader. State: Replica: 9c0fc7d6eac24c599ac0e07d1ffb058c, State: Running, Role: LEADER
02:10:59.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.577865  9154 consensus_queue.cc:237] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [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: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } }
02:10:59.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.584467  8545 catalog_manager.cc:5696] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c reported cstate change: term changed from 0 to 1, leader changed from <none> to 9c0fc7d6eac24c599ac0e07d1ffb058c (127.8.60.1). New cstate: current_term: 1 leader_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "9c0fc7d6eac24c599ac0e07d1ffb058c" member_type: VOTER last_known_addr { host: "127.8.60.1" port: 38569 } health_report { overall_health: HEALTHY } } }
02:10:59.743 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 26756b0c3d134805b8f4bfa0e550ee84 for table 'org.apache.kudu.client.TestHybridTime-1783476654765' with partition [<start>, <end>)
02:10:59.751 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=26756b0c3d134805b8f4bfa0e550ee84@[813ce93995b54f72ba933a61ff091c52(127.8.60.3:40527),9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)[L],a86e53b6263049d79801dd246c58d460(127.8.60.2:39043)]}]
02:10:59.753 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=27), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.8.60.61:35335, [13ms] Sub RPC GetTableLocations: received response from server master-127.8.60.61:35335: OK, deferred=null) after lookup
02:10:59.765 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)] connecting to peer
02:10:59.768 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)] Successfully connected to peer
02:10:59.863 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x859de5f3, L:/127.0.0.1:34688 - R:/127.8.60.1:38569] using TOKEN/null
02:10:59.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.874037  9068 raft_consensus.cc:1275] T 26756b0c3d134805b8f4bfa0e550ee84 P 813ce93995b54f72ba933a61ff091c52 [term 1 FOLLOWER]: Refusing update from remote peer 9c0fc7d6eac24c599ac0e07d1ffb058c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:10:59.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.874006  8933 raft_consensus.cc:1275] T 26756b0c3d134805b8f4bfa0e550ee84 P a86e53b6263049d79801dd246c58d460 [term 1 FOLLOWER]: Refusing update from remote peer 9c0fc7d6eac24c599ac0e07d1ffb058c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:10:59.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.875231  9158 consensus_queue.cc:1048] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [LEADER]: Connected to new peer: Peer: permanent_uuid: "813ce93995b54f72ba933a61ff091c52" member_type: VOTER last_known_addr { host: "127.8.60.3" port: 40527 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:10:59.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.875447  9154 consensus_queue.cc:1048] T 26756b0c3d134805b8f4bfa0e550ee84 P 9c0fc7d6eac24c599ac0e07d1ffb058c [LEADER]: Connected to new peer: Peer: permanent_uuid: "a86e53b6263049d79801dd246c58d460" member_type: VOTER last_known_addr { host: "127.8.60.2" port: 39043 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:10:59.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.887638  9164 mvcc.cc:204] Tried to move back new op lower bound from 7305120398834315264 to 7305120397637357568. Current Snapshot: MvccSnapshot[applied={T|T < 7305120398834315264}]
02:10:59.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.892513  9168 mvcc.cc:204] Tried to move back new op lower bound from 7305120398834315264 to 7305120397637357568. Current Snapshot: MvccSnapshot[applied={T|T < 7305120398834315264}]
02:10:59.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:10:59.893935  9167 mvcc.cc:204] Tried to move back new op lower bound from 7305120398834315264 to 7305120397637357568. Current Snapshot: MvccSnapshot[applied={T|T < 7305120398834315264}]
02:10:59.967 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.017 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.034 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.048 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1846508457(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:00.068 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.070 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1049592993(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:00.083 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.083 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1702241886(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:11:00.095 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:11:00.184 [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-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.196 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305120419314315265) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.202 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305120419314315269) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.211 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305120419314315273) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.218 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305120419314315277) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.229 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305120419314315281) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.237 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305120419314315285) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.251 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305120419314315286) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476654765, tablet=26756b0c3d134805b8f4bfa0e550ee84, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:11:00.256 [DEBUG - main] (Connection.java:575) [peer 9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)] disconnecting while in state READY
02:11:00.258 [DEBUG - main] (Connection.java:575) [peer master-127.8.60.62:38165(127.8.60.62:38165)] disconnecting while in state READY
02:11:00.258 [DEBUG - main] (Connection.java:575) [peer master-127.8.60.61:35335(127.8.60.61:35335)] disconnecting while in state READY
02:11:00.258 [DEBUG - main] (Connection.java:575) [peer master-127.8.60.60:45817(127.8.60.60:45817)] disconnecting while in state READY
02:11:00.265 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.8.60.62:38165(127.8.60.62:38165)] handling channelInactive
02:11:00.266 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.8.60.60:45817(127.8.60.60:45817)] handling channelInactive
02:11:00.266 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.8.60.61:35335(127.8.60.61:35335)] handling channelInactive
02:11:00.266 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.8.60.61:35335(127.8.60.61:35335)] cleaning up while in state READY due to: connection closed
02:11:00.266 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.8.60.62:38165(127.8.60.62:38165)] cleaning up while in state READY due to: connection closed
02:11:00.267 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.8.60.60:45817(127.8.60.60:45817)] cleaning up while in state READY due to: connection closed
02:11:00.267 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
02:11:00.275 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)] handling channelInactive
02:11:00.275 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 9c0fc7d6eac24c599ac0e07d1ffb058c(127.8.60.1:38569)] cleaning up while in state READY due to: connection closed
02:11:00.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.275224  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8714
02:11:00.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.284999  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8852
02:11:00.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.296516  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8987
02:11:00.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.310192  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8443
02:11:00.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.322018  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8512
02:11:00.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:11:00.336005  8432 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskVVPWlf/build/debug/bin/kudu with pid 8584
02:11:00.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:11:00Z chronyd exiting

Time: 5.512

OK (1 test)

