JUnit version 4.13.2
.19:58:47.880 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783540727871
19:58:47.908 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
19:58:47.974 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
19:58:47.981 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task_vfL3T/test-tmp
19:58:47.986 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
19:58:47.988 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task_vfL3T/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
19:58:48.205 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

19:58:48.388 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
19:58:48.389 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

19:58:48.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.393067  7785 mini_oidc.cc:150] Starting JWKS server
19:58:48.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.395982  7785 webserver.cc:533] Webserver started at http://127.0.0.1:45173/ using document root <none> and password file <none>
19:58:48.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.396270  7785 mini_oidc.cc:186] Starting OIDC Discovery server
19:58:48.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.396948  7785 webserver.cc:533] Webserver started at http://127.0.0.1:35271/ using document root <none> and password file <none>
19:58:48.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T19:58:48Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
19:58:48.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T19:58:48Z Disabled control of system clock
19:58:48.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.425282  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:48.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:48.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal
19:58:48.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data
19:58:48.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:48.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:48.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:48.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:48.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:48.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:48.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/logs
19:58:48.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data/info.pb
19:58:48.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:48.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:48.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:48.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:48.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:48.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:48.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:48.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:48.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:58:48.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:48.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:48.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:48.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.126:34729
19:58:48.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.126
19:58:48.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:48.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:48.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:48.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:48.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:48.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:48.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:48.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:48.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json with env {}
19:58:48.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.745088  7796 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:48.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.745393  7796 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:48.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.745471  7796 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754067  7796 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
19:58:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754155  7796 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754211  7796 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
19:58:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754312  7796 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
19:58:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754369  7796 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
19:58:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.754405  7796 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:45173/jwks.json
19:58:48.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.764650  7796 master_runner.cc:387] Master server non-default flags:
19:58:48.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:48.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:48.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:48.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:48.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data
19:58:48.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:48.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.126:34729
19:58:48.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:48.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:48.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:48.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json
19:58:48.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:48.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:48.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data/info.pb
19:58:48.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.126
19:58:48.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:48.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/logs
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:48.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:48.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:48.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:48.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:48.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.766489  7796 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:48.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.768407  7796 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:48.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.777292  7802 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
19:58:48.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.777312  7801 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
19:58:48.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.778030  7804 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
19:58:48.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.779080  7796 server_base.cc:1061] running on GCE node
19:58:48.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.779973  7796 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:48.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.781462  7796 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:48.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.782949  7796 hybrid_clock.cc:648] HybridClock initialized: now 1783540728782857 us; error 112 us; skew 500 ppm
19:58:48.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.783476  7796 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:48.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.786039  7796 webserver.cc:533] Webserver started at http://127.7.154.126:40053/ using document root <none> and password file <none>
19:58:48.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.786906  7796 fs_manager.cc:362] Metadata directory not provided
19:58:48.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.787045  7796 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:48.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.787525  7796 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:48.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.790048  7796 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data/instance:
19:58:48.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "135131a943704ed5b44fcb93979a7cef"
19:58:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:48 on dist-test-slave-4dln"
19:58:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.791013  7796 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal/instance:
19:58:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "135131a943704ed5b44fcb93979a7cef"
19:58:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:48 on dist-test-slave-4dln"
19:58:48.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.796595  7796 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.000s
19:58:48.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.800066  7810 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:48.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.801427  7796 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
19:58:48.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.801621  7796 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal
19:58:48.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "135131a943704ed5b44fcb93979a7cef"
19:58:48.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:48 on dist-test-slave-4dln"
19:58:48.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.801874  7796 fs_report.cc:389] FS layout report
19:58:48.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:48.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal
19:58:48.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal
19:58:48.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data/data
19:58:48.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:48.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:48.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:48.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:48.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:48.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:48.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:48.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:48.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:48.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:48.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:48.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.827829  7796 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:48.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.828900  7796 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:48.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.829227  7796 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:48.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.852005  7796 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.126:34729
19:58:48.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.852025  7861 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.126:34729 every 8 connection(s)
19:58:48.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.853819  7796 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/data/info.pb
19:58:48.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.858146  7862 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:48.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.863986  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 7796
19:58:48.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.864243  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-0/wal/instance
19:58:48.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.863771  7862 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } has no permanent_uuid. Determining permanent_uuid...
19:58:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.866844  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal
19:58:48.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data
19:58:48.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:48.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:48.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:48.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:48.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:48.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:48.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/logs
19:58:48.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data/info.pb
19:58:48.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:48.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:48.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:48.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:48.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:48.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:48.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:48.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:48.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:58:48.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:48.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.125:39263
19:58:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.125
19:58:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:48.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:48.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:48.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:48.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:48.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json with env {}
19:58:48.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.893646  7862 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } has no permanent_uuid. Determining permanent_uuid...
19:58:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.894986  7814 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:48.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.896765  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.125:39263: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:48.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:48.946156  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } attempt: 1
19:58:48.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:48.948482  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.125:39263: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:49.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.016746  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } attempt: 2
19:58:49.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.019057  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.125:39263: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:49.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.110262  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } attempt: 3
19:58:49.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.112579  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.125:39263: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:49.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.203167  7866 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:49.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.203554  7866 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:49.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.203650  7866 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:49.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212360  7866 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
19:58:49.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212460  7866 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:49.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212522  7866 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
19:58:49.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212567  7866 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
19:58:49.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212627  7866 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
19:58:49.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.212667  7866 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:45173/jwks.json
19:58:49.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.229605  7866 master_runner.cc:387] Master server non-default flags:
19:58:49.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:49.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:49.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:49.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.125:39263
19:58:49.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data/info.pb
19:58:49.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.125
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:49.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/logs
19:58:49.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:49.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:49.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:49.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:58:49.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:49.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:49.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:49.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:49.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:49.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:49.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.231967  7866 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:49.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.234390  7866 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:49.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.244141  7872 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
19:58:49.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.244144  7873 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
19:58:49.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.244386  7875 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
19:58:49.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.245554  7866 server_base.cc:1061] running on GCE node
19:58:49.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.246541  7866 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:49.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.248134  7866 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:49.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.249356  7866 hybrid_clock.cc:648] HybridClock initialized: now 1783540729249298 us; error 56 us; skew 500 ppm
19:58:49.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.249691  7866 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:49.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.252238  7866 webserver.cc:533] Webserver started at http://127.7.154.125:38431/ using document root <none> and password file <none>
19:58:49.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.253158  7866 fs_manager.cc:362] Metadata directory not provided
19:58:49.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.253284  7866 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:49.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.253726  7866 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.255851  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } attempt: 4
19:58:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.256338  7866 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data/instance:
19:58:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6d17f033259e4e63ab7d0ff26f6176e3"
19:58:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.257426  7866 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal/instance:
19:58:49.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6d17f033259e4e63ab7d0ff26f6176e3"
19:58:49.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.258042  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.125:39263: Network error: Client connection negotiation failed: client connection to 127.7.154.125:39263: connect: Connection refused (error 111)
19:58:49.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.263644  7866 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.004s	sys 0.004s
19:58:49.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.267203  7881 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:49.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.268560  7866 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
19:58:49.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.268767  7866 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal
19:58:49.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6d17f033259e4e63ab7d0ff26f6176e3"
19:58:49.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.269006  7866 fs_report.cc:389] FS layout report
19:58:49.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data/data
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:49.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:49.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:49.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:49.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.292023  7866 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:49.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.293054  7866 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:49.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.293383  7866 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:49.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.314603  7866 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.125:39263
19:58:49.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.314625  7932 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.125:39263 every 8 connection(s)
19:58:49.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.316359  7866 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/data/info.pb
19:58:49.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.317183  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 7866
19:58:49.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.317425  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-1/wal/instance
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.318814  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:49.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/logs
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data/info.pb
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
19:58:49.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.124:36881
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.124
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:49.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:49.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json with env {}
19:58:49.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.324770  7933 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:49.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.334136  7933 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.350231  7933 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.359627  7933 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.360733  7885 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.362499  7933 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.411780  7933 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 1
19:58:49.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.414161  7933 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.482401  7933 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 2
19:58:49.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.484647  7933 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.557294  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } attempt: 5
19:58:49.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.564446  7862 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.566483  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.575861  7933 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 3
19:58:49.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.577942  7933 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.617702  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 1
19:58:49.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.619747  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.664049  7935 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:49.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.664350  7935 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:49.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.664436  7935 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673585  7935 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
19:58:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673682  7935 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673743  7935 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
19:58:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673786  7935 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
19:58:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673842  7935 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
19:58:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.673880  7935 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:45173/jwks.json
19:58:49.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.684839  7935 master_runner.cc:387] Master server non-default flags:
19:58:49.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:49.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:49.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:49.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:49.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.124:36881
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45173/jwks.json
19:58:49.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data/info.pb
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.124
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:49.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/logs
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
19:58:49.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:49.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.686733  7935 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:49.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.688004  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 2
19:58:49.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.688936  7935 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:49.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.690547  7862 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.697379  7944 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
19:58:49.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.697395  7943 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
19:58:49.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.698536  7946 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
19:58:49.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.699079  7935 server_base.cc:1061] running on GCE node
19:58:49.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.699858  7935 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:49.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.701216  7935 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:49.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.702467  7935 hybrid_clock.cc:648] HybridClock initialized: now 1783540729702402 us; error 48 us; skew 500 ppm
19:58:49.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.702899  7935 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:49.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.705251  7935 webserver.cc:533] Webserver started at http://127.7.154.124:42475/ using document root <none> and password file <none>
19:58:49.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.706096  7935 fs_manager.cc:362] Metadata directory not provided
19:58:49.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.706236  7935 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:49.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.706753  7935 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:49.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.709476  7935 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data/instance:
19:58:49.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "584cdcbe9a1749759ad0f20859fd8071"
19:58:49.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.710462  7935 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal/instance:
19:58:49.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "584cdcbe9a1749759ad0f20859fd8071"
19:58:49.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.715947  7935 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.001s
19:58:49.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.719379  7952 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:49.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.720665  7935 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.720860  7935 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "584cdcbe9a1749759ad0f20859fd8071"
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:49 on dist-test-slave-4dln"
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.721119  7935 fs_report.cc:389] FS layout report
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal
19:58:49.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data/data
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:49.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:49.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:49.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:49.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.721305  7933 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 4
19:58:49.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.723093  7933 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.7.154.124:36881: Network error: Client connection negotiation failed: client connection to 127.7.154.124:36881: connect: Connection refused (error 111)
19:58:49.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.741962  7935 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:49.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.742970  7935 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:49.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.743285  7935 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:49.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.763792  7935 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.124:36881
19:58:49.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.763824  8003 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.124:36881 every 8 connection(s)
19:58:49.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.765493  7935 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/data/info.pb
19:58:49.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.767750  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 7935
19:58:49.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.767962  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/master-2/wal/instance
19:58:49.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.769863  8004 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:49.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.777717  8004 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.789561  8004 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.796274  8004 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } has no permanent_uuid. Determining permanent_uuid...
19:58:49.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.796729  7862 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 3
19:58:49.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.809603  7862 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: Bootstrap starting.
19:58:49.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.809639  8004 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: Bootstrap starting.
19:58:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.813618  8004 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: Neither blocks nor log segments found. Creating new log.
19:58:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.813623  7862 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: Neither blocks nor log segments found. Creating new log.
19:58:49.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.814934  7862 log.cc:826] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: Log is configured to *not* fsync() on all Append() calls
19:58:49.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.814934  8004 log.cc:826] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: Log is configured to *not* fsync() on all Append() calls
19:58:49.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.817888  7862 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: No bootstrap required, opened a new log
19:58:49.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.818120  8004 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: No bootstrap required, opened a new log
19:58:49.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825428  8004 raft_consensus.cc:359] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:49.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825424  7862 raft_consensus.cc:359] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:49.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825745  7862 raft_consensus.cc:385] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:49.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825745  8004 raft_consensus.cc:385] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:49.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825860  7862 raft_consensus.cc:740] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 135131a943704ed5b44fcb93979a7cef, State: Initialized, Role: FOLLOWER
19:58:49.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.825896  8004 raft_consensus.cc:740] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 584cdcbe9a1749759ad0f20859fd8071, State: Initialized, Role: FOLLOWER
19:58:49.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.826543  8004 consensus_queue.cc:260] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:49.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.826551  7862 consensus_queue.cc:260] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.827826  8014 sys_catalog.cc:455] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.828104  8014 sys_catalog.cc:458] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: This master's current role is: FOLLOWER
19:58:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.828504  8015 sys_catalog.cc:455] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.828758  8015 sys_catalog.cc:458] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: This master's current role is: FOLLOWER
19:58:49.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.828852  7862 sys_catalog.cc:565] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: configured and running, proceeding with master startup.
19:58:49.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.828850  8004 sys_catalog.cc:565] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: configured and running, proceeding with master startup.
19:58:49.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.831979  7816 tablet.cc:2406] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:58:49.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.840926  8035 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
19:58:49.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.843865  8035 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
19:58:49.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.840497  7796 master_runner.cc:187] Error getting master registration for 127.7.154.125:39263: OK, instance_id { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" instance_seqno: 1783540729309033 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
19:58:49.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.846613  7796 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
19:58:49.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.844599  7935 master_runner.cc:187] Error getting master registration for 127.7.154.125:39263: OK, instance_id { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" instance_seqno: 1783540729309033 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
19:58:49.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.860219  7935 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
19:58:49.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.862010  8037 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
19:58:49.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.862779  8037 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
19:58:49.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.992131  8014 raft_consensus.cc:493] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
19:58:49.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.992439  8014 raft_consensus.cc:515] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:49.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.994253  8014 leader_election.cc:290] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 135131a943704ed5b44fcb93979a7cef (127.7.154.126:34729), 6d17f033259e4e63ab7d0ff26f6176e3 (127.7.154.125:39263)
19:58:49.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.994885  7837 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "584cdcbe9a1749759ad0f20859fd8071" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "135131a943704ed5b44fcb93979a7cef" is_pre_election: true
19:58:49.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.995384  7837 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 584cdcbe9a1749759ad0f20859fd8071 in term 0.
19:58:49.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:49.995908  7958 tablet.cc:2406] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:58:49.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.997030  7953 leader_election.cc:304] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [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: 135131a943704ed5b44fcb93979a7cef, 584cdcbe9a1749759ad0f20859fd8071; no voters: 
19:58:49.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.997474  8014 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Leader pre-election won for term 1
19:58:49.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.997618  8014 raft_consensus.cc:493] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
19:58:49.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:49.997720  8014 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 0 FOLLOWER]: Advancing to term 1
19:58:50.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.001904  8014 raft_consensus.cc:515] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:50.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.003666  7837 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "584cdcbe9a1749759ad0f20859fd8071" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "135131a943704ed5b44fcb93979a7cef"
19:58:50.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.003882  7837 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 0 FOLLOWER]: Advancing to term 1
19:58:50.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.007403  7837 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 584cdcbe9a1749759ad0f20859fd8071 in term 1.
19:58:50.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.007897  7953 leader_election.cc:304] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [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: 135131a943704ed5b44fcb93979a7cef, 584cdcbe9a1749759ad0f20859fd8071; no voters: 
19:58:50.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.008327  8014 leader_election.cc:290] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [CANDIDATE]: Term 1 election: Requested vote from peers 135131a943704ed5b44fcb93979a7cef (127.7.154.126:34729), 6d17f033259e4e63ab7d0ff26f6176e3 (127.7.154.125:39263)
19:58:50.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.008546  8014 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 1 FOLLOWER]: Leader election won for term 1
19:58:50.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.008671  8014 raft_consensus.cc:697] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [term 1 LEADER]: Becoming Leader. State: Replica: 584cdcbe9a1749759ad0f20859fd8071, State: Running, Role: LEADER
19:58:50.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.009331  8014 consensus_queue.cc:237] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:50.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.018806  8014 sys_catalog.cc:455] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 584cdcbe9a1749759ad0f20859fd8071. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.020393  8014 sys_catalog.cc:458] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: This master's current role is: LEADER
19:58:50.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.022269  7933 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } attempt: 5
19:58:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.028029  8042 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
19:58:50.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.031203  8042 catalog_manager.cc:1520] Initializing Kudu cluster ID...
19:58:50.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.036775  7933 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: Bootstrap starting.
19:58:50.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.044238  7933 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: Neither blocks nor log segments found. Creating new log.
19:58:50.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.046928  7933 log.cc:826] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: Log is configured to *not* fsync() on all Append() calls
19:58:50.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.050194  7837 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [term 1 FOLLOWER]: Refusing update from remote peer 584cdcbe9a1749759ad0f20859fd8071: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:58:50.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.051756  8014 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [LEADER]: Connected to new peer: Peer: permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:58:50.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.061214  7933 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: No bootstrap required, opened a new log
19:58:50.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.077021  7933 raft_consensus.cc:359] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:50.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.077353  8015 sys_catalog.cc:455] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: SysCatalogTable state changed. Reason: New leader 584cdcbe9a1749759ad0f20859fd8071. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.077586  8015 sys_catalog.cc:458] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: This master's current role is: FOLLOWER
19:58:50.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.081225  8043 mvcc.cc:204] Tried to move back new op lower bound from 7305382830273486848 to 7305382830123364352. Current Snapshot: MvccSnapshot[applied={T|T < 7305382830273486848}]
19:58:50.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.083586  7933 raft_consensus.cc:385] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:50.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.084110  7933 raft_consensus.cc:740] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6d17f033259e4e63ab7d0ff26f6176e3, State: Initialized, Role: FOLLOWER
19:58:50.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.085750  7933 consensus_queue.cc:260] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:50.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.091755  8015 sys_catalog.cc:455] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.091953  8015 sys_catalog.cc:458] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef [sys.catalog]: This master's current role is: FOLLOWER
19:58:50.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.103242  8040 sys_catalog.cc:455] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.103587  8040 sys_catalog.cc:458] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: This master's current role is: LEADER
19:58:50.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.105520  8042 catalog_manager.cc:1383] Generated new cluster ID: 416d3c44bff54469b259aa64031476ec
19:58:50.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.105613  8042 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
19:58:50.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.110752  8050 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [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: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.111333  8050 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: This master's current role is: FOLLOWER
19:58:50.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.111676  8050 raft_consensus.cc:493] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
19:58:50.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.112049  8050 raft_consensus.cc:515] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } }
19:58:50.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.118470  7908 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "584cdcbe9a1749759ad0f20859fd8071" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" is_pre_election: true
19:58:50.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.118739  7906 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 0 FOLLOWER]: Advancing to term 1
19:58:50.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.119340  7907 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "584cdcbe9a1749759ad0f20859fd8071" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6d17f033259e4e63ab7d0ff26f6176e3"
19:58:50.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.121198  7933 sys_catalog.cc:565] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: configured and running, proceeding with master startup.
19:58:50.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.122282  7906 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 1 FOLLOWER]: Refusing update from remote peer 584cdcbe9a1749759ad0f20859fd8071: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:58:50.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.123039  8014 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [LEADER]: Connected to new peer: Peer: permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:58:50.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.123494  7836 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "135131a943704ed5b44fcb93979a7cef" is_pre_election: true
19:58:50.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.125092  7979 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "584cdcbe9a1749759ad0f20859fd8071" is_pre_election: true
19:58:50.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.126564  7882 leader_election.cc:304] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: 6d17f033259e4e63ab7d0ff26f6176e3; no voters: 135131a943704ed5b44fcb93979a7cef, 584cdcbe9a1749759ad0f20859fd8071
19:58:50.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.129253  8050 leader_election.cc:290] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 135131a943704ed5b44fcb93979a7cef (127.7.154.126:34729), 584cdcbe9a1749759ad0f20859fd8071 (127.7.154.124:36881)
19:58:50.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.135600  8042 catalog_manager.cc:1406] Generated new certificate authority record
19:58:50.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.137698  8042 catalog_manager.cc:1540] Loading token signing keys...
19:58:50.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.156384  8042 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071: Generated new TSK 0
19:58:50.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.157876  8042 catalog_manager.cc:1550] Initializing in-progress tserver states...
19:58:50.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.164160  8054 mvcc.cc:204] Tried to move back new op lower bound from 7305382830273486848 to 7305382830123364352. Current Snapshot: MvccSnapshot[applied={T|T < 7305382830273486848}]
19:58:50.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.174116  8050 raft_consensus.cc:2749] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [term 1 FOLLOWER]: Leader pre-election lost for term 1. Reason: could not achieve majority
19:58:50.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.175241  8052 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.175575  8052 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: This master's current role is: FOLLOWER
19:58:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.176394  8040 sys_catalog.cc:455] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.176750  8040 sys_catalog.cc:458] T 00000000000000000000000000000000 P 584cdcbe9a1749759ad0f20859fd8071 [sys.catalog]: This master's current role is: LEADER
19:58:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.177773  8049 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 584cdcbe9a1749759ad0f20859fd8071. Latest consensus state: current_term: 1 leader_uuid: "584cdcbe9a1749759ad0f20859fd8071" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "135131a943704ed5b44fcb93979a7cef" member_type: VOTER last_known_addr { host: "127.7.154.126" port: 34729 } } peers { permanent_uuid: "6d17f033259e4e63ab7d0ff26f6176e3" member_type: VOTER last_known_addr { host: "127.7.154.125" port: 39263 } } peers { permanent_uuid: "584cdcbe9a1749759ad0f20859fd8071" member_type: VOTER last_known_addr { host: "127.7.154.124" port: 36881 } } }
19:58:50.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.178128  8049 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3 [sys.catalog]: This master's current role is: FOLLOWER
19:58:50.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.189590  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/logs
19:58:50.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data/info.pb
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:50.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.65:0
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.65
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.65
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:50.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:58:50.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.274313  8067 catalog_manager.cc:1295] Loaded cluster ID: 416d3c44bff54469b259aa64031476ec
19:58:50.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.274430  8067 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: loading cluster ID for follower catalog manager: success
19:58:50.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.278596  8067 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: acquiring CA information for follower catalog manager: success
19:58:50.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.281491  8067 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 6d17f033259e4e63ab7d0ff26f6176e3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
19:58:50.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.686201  8063 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:50.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.686605  8063 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:50.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.686738  8063 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:50.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.700757  8063 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:50.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.701316  8063 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.154.65
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.717689  8063 tablet_server_runner.cc:78] Tablet server non-default flags:
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.65:0
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:50.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data/info.pb
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.65
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.65
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/logs
19:58:50.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:50.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:50.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.722543  8063 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:50.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.724977  8063 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:50.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.734712  8073 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
19:58:50.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.735158  8074 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
19:58:50.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:50.739523  8076 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
19:58:50.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.740127  8063 server_base.cc:1061] running on GCE node
19:58:50.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.740800  8063 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:50.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.741804  8063 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:50.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.743387  8063 hybrid_clock.cc:648] HybridClock initialized: now 1783540730742957 us; error 361 us; skew 500 ppm
19:58:50.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.743818  8063 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:50.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.746342  8063 webserver.cc:533] Webserver started at http://127.7.154.65:33153/ using document root <none> and password file <none>
19:58:50.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.747212  8063 fs_manager.cc:362] Metadata directory not provided
19:58:50.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.747361  8063 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:50.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.747905  8063 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:50.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.750882  8063 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data/instance:
19:58:50.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05"
19:58:50.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:50 on dist-test-slave-4dln"
19:58:50.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.751827  8063 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal/instance:
19:58:50.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05"
19:58:50.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:50 on dist-test-slave-4dln"
19:58:50.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.760852  8063 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.002s	sys 0.005s
19:58:50.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.764483  8082 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.765898  8063 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.766068  8063 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05"
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:50 on dist-test-slave-4dln"
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.766326  8063 fs_report.cc:389] FS layout report
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal
19:58:50.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data/data
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:50.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:50.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:50.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:50.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.790441  8063 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:50.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.791394  8063 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:50.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.791707  8063 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:50.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.792779  8063 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
19:58:50.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.794687  8063 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:58:50.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.794803  8063 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:58:50.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.794902  8063 ts_tablet_manager.cc:616] Registered 0 tablets
19:58:50.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.794983  8063 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:58:50.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.836362  8063 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.65:36839
19:58:50.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.836411  8194 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.65:36839 every 8 connection(s)
19:58:50.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.838208  8063 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/data/info.pb
19:58:50.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.848726  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 8063
19:58:50.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.849200  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-0/wal/instance
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.857096  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:50.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/logs
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data/info.pb
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.66:0
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.66
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.66
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:50.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:50.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:50.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:50.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:58:50.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.865592  8037 catalog_manager.cc:1295] Loaded cluster ID: 416d3c44bff54469b259aa64031476ec
19:58:50.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.865692  8037 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: loading cluster ID for follower catalog manager: success
19:58:50.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.873051  8037 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: acquiring CA information for follower catalog manager: success
19:58:50.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.881457  8037 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 135131a943704ed5b44fcb93979a7cef: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
19:58:50.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.914036  8195 heartbeater.cc:344] Connected to a master server at 127.7.154.124:36881
19:58:50.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.914083  8196 heartbeater.cc:344] Connected to a master server at 127.7.154.126:34729
19:58:50.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.914461  8196 heartbeater.cc:461] Registering TS with master...
19:58:50.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.914465  8195 heartbeater.cc:461] Registering TS with master...
19:58:50.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.916150  8195 heartbeater.cc:507] Master 127.7.154.124:36881 requested a full tablet report, sending...
19:58:50.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.916452  8196 heartbeater.cc:507] Master 127.7.154.126:34729 requested a full tablet report, sending...
19:58:50.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.919443  7969 ts_manager.cc:194] Registered new tserver with Master: 7e5e79e42c9c41b69e02e5c87a6d3c05 (127.7.154.65:36839)
19:58:50.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.921562  7969 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.154.65:45101
19:58:50.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.924448  7827 ts_manager.cc:194] Registered new tserver with Master: 7e5e79e42c9c41b69e02e5c87a6d3c05 (127.7.154.65:36839)
19:58:50.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.925791  8199 heartbeater.cc:344] Connected to a master server at 127.7.154.125:39263
19:58:50.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.925943  8199 heartbeater.cc:461] Registering TS with master...
19:58:50.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.926636  8199 heartbeater.cc:507] Master 127.7.154.125:39263 requested a full tablet report, sending...
19:58:50.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:50.928194  7898 ts_manager.cc:194] Registered new tserver with Master: 7e5e79e42c9c41b69e02e5c87a6d3c05 (127.7.154.65:36839)
19:58:51.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.255414  8202 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:51.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.255761  8202 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:51.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.255895  8202 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:51.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.265035  8202 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:51.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.265254  8202 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.154.66
19:58:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.276268  8202 tablet_server_runner.cc:78] Tablet server non-default flags:
19:58:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:51.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.66:0
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data/info.pb
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.66
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:51.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.66
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/logs
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:51.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.278538  8202 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:51.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.280499  8202 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:51.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.290413  8210 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
19:58:51.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.290477  8211 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
19:58:51.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.291158  8213 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
19:58:51.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.292181  8202 server_base.cc:1061] running on GCE node
19:58:51.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.292848  8202 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:51.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.293947  8202 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:51.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.295184  8202 hybrid_clock.cc:648] HybridClock initialized: now 1783540731295127 us; error 62 us; skew 500 ppm
19:58:51.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.295542  8202 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:51.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.297703  8202 webserver.cc:533] Webserver started at http://127.7.154.66:45409/ using document root <none> and password file <none>
19:58:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.298442  8202 fs_manager.cc:362] Metadata directory not provided
19:58:51.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.298532  8202 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:51.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.298928  8202 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:51.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.301515  8202 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data/instance:
19:58:51.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7a2d9211b84e404cab0ec3b870b4e849"
19:58:51.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.302227  8202 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal/instance:
19:58:51.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7a2d9211b84e404cab0ec3b870b4e849"
19:58:51.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.307504  8202 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.002s	sys 0.005s
19:58:51.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.310784  8219 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.312085  8202 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.312220  8202 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7a2d9211b84e404cab0ec3b870b4e849"
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.312397  8202 fs_report.cc:389] FS layout report
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data/data
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:51.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:51.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.346899  8202 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:51.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.347734  8202 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:51.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.347970  8202 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:51.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.348867  8202 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
19:58:51.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.350616  8202 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:58:51.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.350701  8202 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:58:51.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.350805  8202 ts_tablet_manager.cc:616] Registered 0 tablets
19:58:51.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.350872  8202 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:58:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.382373  8202 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.66:37135
19:58:51.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.382454  8331 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.66:37135 every 8 connection(s)
19:58:51.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.383939  8202 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/data/info.pb
19:58:51.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.392786  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 8202
19:58:51.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.392997  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-1/wal/instance
19:58:51.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.399561  7785 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:51.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_vfL3T/build/asan/bin/kudu
19:58:51.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/logs
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data/info.pb
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
19:58:51.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.67:0
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.67
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.67
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
19:58:51.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.401747  8333 heartbeater.cc:344] Connected to a master server at 127.7.154.126:34729
19:58:51.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.401798  8332 heartbeater.cc:344] Connected to a master server at 127.7.154.124:36881
19:58:51.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.402179  8333 heartbeater.cc:461] Registering TS with master...
19:58:51.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.402179  8332 heartbeater.cc:461] Registering TS with master...
19:58:51.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.402954  8334 heartbeater.cc:344] Connected to a master server at 127.7.154.125:39263
19:58:51.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.403119  8334 heartbeater.cc:461] Registering TS with master...
19:58:51.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.403450  8332 heartbeater.cc:507] Master 127.7.154.124:36881 requested a full tablet report, sending...
19:58:51.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.403491  8333 heartbeater.cc:507] Master 127.7.154.126:34729 requested a full tablet report, sending...
19:58:51.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.403663  8334 heartbeater.cc:507] Master 127.7.154.125:39263 requested a full tablet report, sending...
19:58:51.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.405242  7827 ts_manager.cc:194] Registered new tserver with Master: 7a2d9211b84e404cab0ec3b870b4e849 (127.7.154.66:37135)
19:58:51.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.406051  7898 ts_manager.cc:194] Registered new tserver with Master: 7a2d9211b84e404cab0ec3b870b4e849 (127.7.154.66:37135)
19:58:51.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.406183  7969 ts_manager.cc:194] Registered new tserver with Master: 7a2d9211b84e404cab0ec3b870b4e849 (127.7.154.66:37135)
19:58:51.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.406940  7969 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.154.66:41333
19:58:51.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.719453  8339 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
19:58:51.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.719772  8339 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
19:58:51.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.719885  8339 flags.cc:432] Enabled unsafe flag: --never_fsync=true
19:58:51.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.728294  8339 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
19:58:51.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.728502  8339 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.154.67
19:58:51.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.738624  8339 tablet_server_runner.cc:78] Tablet server non-default flags:
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.154.84:39519
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
19:58:51.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.154.67:0
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data/info.pb
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.154.67
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.154.126:34729,127.7.154.125:39263,127.7.154.124:36881
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.154.67
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/logs
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
19:58:51.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:25 UTC on bdcb31816ec0
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12778
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
19:58:51.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.740939  8339 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
19:58:51.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.742937  8339 file_cache.cc:504] Constructed file cache file cache with capacity 419430
19:58:51.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.752475  8344 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
19:58:51.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.752521  8345 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
19:58:51.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:51.752626  8347 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
19:58:51.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.753677  8339 server_base.cc:1061] running on GCE node
19:58:51.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.754261  8339 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
19:58:51.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.755226  8339 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
19:58:51.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.756464  8339 hybrid_clock.cc:648] HybridClock initialized: now 1783540731756411 us; error 42 us; skew 500 ppm
19:58:51.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.756816  8339 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
19:58:51.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.758931  8339 webserver.cc:533] Webserver started at http://127.7.154.67:43979/ using document root <none> and password file <none>
19:58:51.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.759720  8339 fs_manager.cc:362] Metadata directory not provided
19:58:51.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.759850  8339 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
19:58:51.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.760242  8339 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
19:58:51.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.762549  8339 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data/instance:
19:58:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7825bc8b00634ee8a28248b476e9a316"
19:58:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.763433  8339 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal/instance:
19:58:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7825bc8b00634ee8a28248b476e9a316"
19:58:51.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.768680  8339 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.001s
19:58:51.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.772142  8353 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
19:58:51.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.773438  8339 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
19:58:51.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.773607  8339 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data,/tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal
19:58:51.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7825bc8b00634ee8a28248b476e9a316"
19:58:51.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 19:58:51 on dist-test-slave-4dln"
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.773829  8339 fs_report.cc:389] FS layout report
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data/data
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
19:58:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
19:58:51.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
19:58:51.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.790411  8339 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
19:58:51.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.791234  8339 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
19:58:51.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.791586  8339 kserver.cc:163] Server-wide thread pool size limit: 3276
19:58:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.792520  8339 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
19:58:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.794054  8339 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
19:58:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.794174  8339 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
19:58:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.794289  8339 ts_tablet_manager.cc:616] Registered 0 tablets
19:58:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.794371  8339 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
19:58:51.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.828181  8339 rpc_server.cc:307] RPC server started. Bound to: 127.7.154.67:42245
19:58:51.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.828225  8465 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.154.67:42245 every 8 connection(s)
19:58:51.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.829566  8339 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/data/info.pb
19:58:51.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.839502  7785 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_vfL3T/build/asan/bin/kudu as pid 8339
19:58:51.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.839694  7785 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_vfL3T/test-tmp/mini-kudu-cluster10667649090543294395/ts-2/wal/instance
19:58:51.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.859365  8468 heartbeater.cc:344] Connected to a master server at 127.7.154.125:39263
19:58:51.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.859359  8467 heartbeater.cc:344] Connected to a master server at 127.7.154.126:34729
19:58:51.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.859843  8467 heartbeater.cc:461] Registering TS with master...
19:58:51.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.860823  8467 heartbeater.cc:507] Master 127.7.154.126:34729 requested a full tablet report, sending...
19:58:51.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.859418  8466 heartbeater.cc:344] Connected to a master server at 127.7.154.124:36881
19:58:51.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.861768  8466 heartbeater.cc:461] Registering TS with master...
19:58:51.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.862207  8466 heartbeater.cc:507] Master 127.7.154.124:36881 requested a full tablet report, sending...
19:58:51.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.859840  8468 heartbeater.cc:461] Registering TS with master...
19:58:51.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.863097  8468 heartbeater.cc:507] Master 127.7.154.125:39263 requested a full tablet report, sending...
19:58:51.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.863749  7969 ts_manager.cc:194] Registered new tserver with Master: 7825bc8b00634ee8a28248b476e9a316 (127.7.154.67:42245)
19:58:51.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.864413  7898 ts_manager.cc:194] Registered new tserver with Master: 7825bc8b00634ee8a28248b476e9a316 (127.7.154.67:42245)
19:58:51.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.864728  7969 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.7.154.67:37735
19:58:51.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.865963  7827 ts_manager.cc:194] Registered new tserver with Master: 7825bc8b00634ee8a28248b476e9a316 (127.7.154.67:42245)
19:58:51.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.868670  7785 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
19:58:51.871 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
19:58:51.872 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

19:58:51.882 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.154.126"
      port: 34729
    }
    bound_http_address {
      host: "127.7.154.126"
      port: 40053
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.154.125"
      port: 39263
    }
    bound_http_address {
      host: "127.7.154.125"
      port: 38431
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.154.124"
      port: 36881
    }
    bound_http_address {
      host: "127.7.154.124"
      port: 42475
    }
  }
}

19:58:51.886 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

19:58:51.888 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.154.65"
      port: 36839
    }
    bound_http_address {
      host: "127.7.154.65"
      port: 33153
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.154.66"
      port: 37135
    }
    bound_http_address {
      host: "127.7.154.66"
      port: 45409
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.154.67"
      port: 42245
    }
    bound_http_address {
      host: "127.7.154.67"
      port: 43979
    }
  }
}

19:58:51.889 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
19:58:51.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:51.927541  8195 heartbeater.cc:499] Master 127.7.154.124:36881 was elected leader, sending a full tablet report...
19:58:52.085 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
19:58:52.144 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
19:58:52.282 [DEBUG - main] (Connection.java:748) [peer master-127.7.154.126:34729(127.7.154.126:34729)] connecting to peer
19:58:52.337 [DEBUG - main] (Connection.java:748) [peer master-127.7.154.124:36881(127.7.154.124:36881)] connecting to peer
19:58:52.339 [DEBUG - main] (Connection.java:748) [peer master-127.7.154.125:39263(127.7.154.125:39263)] connecting to peer
19:58:52.353 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.154.126:34729(127.7.154.126:34729)] Successfully connected to peer
19:58:52.353 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.154.124:36881(127.7.154.124:36881)] Successfully connected to peer
19:58:52.353 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.7.154.125:39263(127.7.154.125:39263)] Successfully connected to peer
19:58:52.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.409416  8332 heartbeater.cc:499] Master 127.7.154.124:36881 was elected leader, sending a full tablet report...
19:58:52.442 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.154.125
19:58:52.442 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.154.126
19:58:52.442 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.7.154.124
19:58:52.645 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x3bfab0a9, L:/127.0.0.1:39794 - R:/127.7.154.126:34729] using SASL/PLAIN
19:58:52.645 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xc4b5270b, L:/127.0.0.1:42208 - R:/127.7.154.124:36881] using SASL/PLAIN
19:58:52.645 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0x39751646, L:/127.0.0.1:51920 - R:/127.7.154.125:39263] using SASL/PLAIN
19:58:52.680 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
19:58:52.681 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=435), Traces: [0ms] refreshing cache from master, [24ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.154.126:34729, [88ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.154.124:36881, [90ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.154.125:39263, [409ms] Sub RPC ConnectToMaster: received response from server master-127.7.154.125:39263: OK, [409ms] Sub RPC ConnectToMaster: received response from server master-127.7.154.126:34729: OK, [410ms] Sub RPC ConnectToMaster: received response from server master-127.7.154.124:36881: OK, deferred=null) after lookup
19:58:52.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.726347  7969 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:42208:
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783540727767"
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
19:58:52.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
19:58:52.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:52.728408  7969 catalog_manager.cc:7077] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783540727767 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
19:58:52.796 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 906fd0f3c38d484486d4b4ff5a838bd3
19:58:52.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.815928  8130 tablet_service.cc:1511] Processing CreateTablet for tablet d002365ccfe04b448b88db9959ea96ba (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540727767 [id=906fd0f3c38d484486d4b4ff5a838bd3]), partition=RANGE (key) PARTITION UNBOUNDED
19:58:52.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.817776  8130 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d002365ccfe04b448b88db9959ea96ba. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:52.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.819351  8267 tablet_service.cc:1511] Processing CreateTablet for tablet d002365ccfe04b448b88db9959ea96ba (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540727767 [id=906fd0f3c38d484486d4b4ff5a838bd3]), partition=RANGE (key) PARTITION UNBOUNDED
19:58:52.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.821137  8267 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d002365ccfe04b448b88db9959ea96ba. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:52.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.827203  8401 tablet_service.cc:1511] Processing CreateTablet for tablet d002365ccfe04b448b88db9959ea96ba (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540727767 [id=906fd0f3c38d484486d4b4ff5a838bd3]), partition=RANGE (key) PARTITION UNBOUNDED
19:58:52.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.829727  8401 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d002365ccfe04b448b88db9959ea96ba. 1 dirs total, 0 dirs full, 0 dirs failed
19:58:52.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.851644  8494 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Bootstrap starting.
19:58:52.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.860422  8494 tablet_bootstrap.cc:654] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Neither blocks nor log segments found. Creating new log.
19:58:52.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.862026  8494 log.cc:826] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Log is configured to *not* fsync() on all Append() calls
19:58:52.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.867784  8466 heartbeater.cc:499] Master 127.7.154.124:36881 was elected leader, sending a full tablet report...
19:58:52.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.876252  8494 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: No bootstrap required, opened a new log
19:58:52.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.878566  8494 ts_tablet_manager.cc:1403] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Time spent bootstrapping tablet: real 0.028s	user 0.001s	sys 0.010s
19:58:52.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.885279  8494 raft_consensus.cc:359] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.885890  8494 raft_consensus.cc:385] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:52.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.886134  8494 raft_consensus.cc:740] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7e5e79e42c9c41b69e02e5c87a6d3c05, State: Initialized, Role: FOLLOWER
19:58:52.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.892613  8494 consensus_queue.cc:260] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [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: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.893106  8496 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Bootstrap starting.
19:58:52.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.899206  8494 ts_tablet_manager.cc:1434] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Time spent starting tablet: real 0.020s	user 0.010s	sys 0.001s
19:58:52.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.902750  8496 tablet_bootstrap.cc:654] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Neither blocks nor log segments found. Creating new log.
19:58:52.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.904253  8496 log.cc:826] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Log is configured to *not* fsync() on all Append() calls
19:58:52.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.904551  8498 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Bootstrap starting.
19:58:52.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.907730  8496 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: No bootstrap required, opened a new log
19:58:52.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.908056  8496 ts_tablet_manager.cc:1403] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Time spent bootstrapping tablet: real 0.015s	user 0.002s	sys 0.007s
19:58:52.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.908501  8498 tablet_bootstrap.cc:654] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Neither blocks nor log segments found. Creating new log.
19:58:52.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.909821  8498 log.cc:826] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Log is configured to *not* fsync() on all Append() calls
19:58:52.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.912564  8498 tablet_bootstrap.cc:492] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: No bootstrap required, opened a new log
19:58:52.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.912840  8498 ts_tablet_manager.cc:1403] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Time spent bootstrapping tablet: real 0.009s	user 0.001s	sys 0.006s
19:58:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.916142  8496 raft_consensus.cc:359] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.916532  8496 raft_consensus.cc:385] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:52.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.916646  8496 raft_consensus.cc:740] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7825bc8b00634ee8a28248b476e9a316, State: Initialized, Role: FOLLOWER
19:58:52.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.917380  8496 consensus_queue.cc:260] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [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: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:52.917985  8203 tablet.cc:2406] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:58:52.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.919618  8496 ts_tablet_manager.cc:1434] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Time spent starting tablet: real 0.011s	user 0.011s	sys 0.001s
19:58:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.921329  8498 raft_consensus.cc:359] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.922464  8498 raft_consensus.cc:385] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
19:58:52.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.922592  8498 raft_consensus.cc:740] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7a2d9211b84e404cab0ec3b870b4e849, State: Initialized, Role: FOLLOWER
19:58:52.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.923355  8498 consensus_queue.cc:260] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [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: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:52.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:52.926002  8498 ts_tablet_manager.cc:1434] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Time spent starting tablet: real 0.013s	user 0.011s	sys 0.001s
19:58:53.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:53.084231  8469 tablet.cc:2406] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:58:53.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 19:58:53.139097  8335 tablet.cc:2406] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849: Can't schedule compaction. Clean time has not been advanced past its initial value.
19:58:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.188298  8497 raft_consensus.cc:493] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
19:58:53.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.188551  8497 raft_consensus.cc:515] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:53.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.190529  8497 leader_election.cc:290] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 7a2d9211b84e404cab0ec3b870b4e849 (127.7.154.66:37135), 7825bc8b00634ee8a28248b476e9a316 (127.7.154.67:42245)
19:58:53.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.197916  8421 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d002365ccfe04b448b88db9959ea96ba" candidate_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7825bc8b00634ee8a28248b476e9a316" is_pre_election: true
19:58:53.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.197918  8287 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d002365ccfe04b448b88db9959ea96ba" candidate_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7a2d9211b84e404cab0ec3b870b4e849" is_pre_election: true
19:58:53.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.198457  8421 raft_consensus.cc:2468] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 7e5e79e42c9c41b69e02e5c87a6d3c05 in term 0.
19:58:53.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.198458  8287 raft_consensus.cc:2468] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 7e5e79e42c9c41b69e02e5c87a6d3c05 in term 0.
19:58:53.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.199190  8084 leader_election.cc:304] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 3 yes votes; 0 no votes. yes voters: 7825bc8b00634ee8a28248b476e9a316, 7a2d9211b84e404cab0ec3b870b4e849, 7e5e79e42c9c41b69e02e5c87a6d3c05; no voters: 
19:58:53.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.199875  8497 raft_consensus.cc:2804] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Leader pre-election won for term 1
19:58:53.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.199999  8497 raft_consensus.cc:493] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
19:58:53.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.200060  8497 raft_consensus.cc:3060] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 0 FOLLOWER]: Advancing to term 1
19:58:53.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.202008  8497 raft_consensus.cc:515] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:53.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.202643  8497 leader_election.cc:290] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [CANDIDATE]: Term 1 election: Requested vote from peers 7a2d9211b84e404cab0ec3b870b4e849 (127.7.154.66:37135), 7825bc8b00634ee8a28248b476e9a316 (127.7.154.67:42245)
19:58:53.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.203116  8287 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d002365ccfe04b448b88db9959ea96ba" candidate_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7a2d9211b84e404cab0ec3b870b4e849"
19:58:53.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.203123  8421 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d002365ccfe04b448b88db9959ea96ba" candidate_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7825bc8b00634ee8a28248b476e9a316"
19:58:53.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.203287  8421 raft_consensus.cc:3060] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 0 FOLLOWER]: Advancing to term 1
19:58:53.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.203336  8287 raft_consensus.cc:3060] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 0 FOLLOWER]: Advancing to term 1
19:58:53.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.205416  8421 raft_consensus.cc:2468] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 7e5e79e42c9c41b69e02e5c87a6d3c05 in term 1.
19:58:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.205598  8287 raft_consensus.cc:2468] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 7e5e79e42c9c41b69e02e5c87a6d3c05 in term 1.
19:58:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.205808  8085 leader_election.cc:304] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [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: 7825bc8b00634ee8a28248b476e9a316, 7e5e79e42c9c41b69e02e5c87a6d3c05; no voters: 
19:58:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.206102  8497 raft_consensus.cc:2804] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 1 FOLLOWER]: Leader election won for term 1
19:58:53.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.206511  8497 raft_consensus.cc:697] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [term 1 LEADER]: Becoming Leader. State: Replica: 7e5e79e42c9c41b69e02e5c87a6d3c05, State: Running, Role: LEADER
19:58:53.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.207233  8497 consensus_queue.cc:237] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [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: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } }
19:58:53.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.214560  7968 catalog_manager.cc:5697] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 reported cstate change: term changed from 0 to 1, leader changed from <none> to 7e5e79e42c9c41b69e02e5c87a6d3c05 (127.7.154.65). New cstate: current_term: 1 leader_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7e5e79e42c9c41b69e02e5c87a6d3c05" member_type: VOTER last_known_addr { host: "127.7.154.65" port: 36839 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 } health_report { overall_health: UNKNOWN } } }
19:58:53.377 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet d002365ccfe04b448b88db9959ea96ba for table 'org.apache.kudu.client.TestHybridTime-1783540727767' with partition [<start>, <end>)
19:58:53.384 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=d002365ccfe04b448b88db9959ea96ba@[7825bc8b00634ee8a28248b476e9a316(127.7.154.67:42245),7a2d9211b84e404cab0ec3b870b4e849(127.7.154.66:37135),7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)[L]]}]
19:58:53.385 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.154.124:36881, [7ms] Sub RPC GetTableLocations: received response from server master-127.7.154.124:36881: OK, deferred=null) after lookup
19:58:53.395 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)] connecting to peer
19:58:53.397 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)] Successfully connected to peer
19:58:53.454 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x12bb6f46, L:/127.0.0.1:54842 - R:/127.7.154.65:36839] using TOKEN/null
19:58:53.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.463783  8287 raft_consensus.cc:1275] T d002365ccfe04b448b88db9959ea96ba P 7a2d9211b84e404cab0ec3b870b4e849 [term 1 FOLLOWER]: Refusing update from remote peer 7e5e79e42c9c41b69e02e5c87a6d3c05: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:58:53.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.463783  8421 raft_consensus.cc:1275] T d002365ccfe04b448b88db9959ea96ba P 7825bc8b00634ee8a28248b476e9a316 [term 1 FOLLOWER]: Refusing update from remote peer 7e5e79e42c9c41b69e02e5c87a6d3c05: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
19:58:53.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.464872  8505 consensus_queue.cc:1048] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7825bc8b00634ee8a28248b476e9a316" member_type: VOTER last_known_addr { host: "127.7.154.67" port: 42245 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:58:53.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.465119  8497 consensus_queue.cc:1048] T d002365ccfe04b448b88db9959ea96ba P 7e5e79e42c9c41b69e02e5c87a6d3c05 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7a2d9211b84e404cab0ec3b870b4e849" member_type: VOTER last_known_addr { host: "127.7.154.66" port: 37135 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
19:58:53.535 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.548 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.556 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.559 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@490230610(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:58:53.571 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.572 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@891501252(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:58:53.581 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.581 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1405467926(state=PENDING, result=null, callback=<none>, errback=<none>)}
19:58:53.589 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
19:58:53.639 [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-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.647 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305382864737136641) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.652 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305382864737136644) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.657 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305382864737136648) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.663 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305382864737136652) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.668 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305382864737136656) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.674 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305382864737136660) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.679 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305382864737136661) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540727767, tablet=d002365ccfe04b448b88db9959ea96ba, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
19:58:53.682 [DEBUG - main] (Connection.java:575) [peer 7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)] disconnecting while in state READY
19:58:53.683 [DEBUG - main] (Connection.java:575) [peer master-127.7.154.125:39263(127.7.154.125:39263)] disconnecting while in state READY
19:58:53.683 [DEBUG - main] (Connection.java:575) [peer master-127.7.154.124:36881(127.7.154.124:36881)] disconnecting while in state READY
19:58:53.683 [DEBUG - main] (Connection.java:575) [peer master-127.7.154.126:34729(127.7.154.126:34729)] disconnecting while in state READY
19:58:53.697 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.154.124:36881(127.7.154.124:36881)] handling channelInactive
19:58:53.698 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.154.124:36881(127.7.154.124:36881)] cleaning up while in state READY due to: connection closed
19:58:53.699 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.154.126:34729(127.7.154.126:34729)] handling channelInactive
19:58:53.699 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.154.126:34729(127.7.154.126:34729)] cleaning up while in state READY due to: connection closed
19:58:53.700 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.7.154.125:39263(127.7.154.125:39263)] handling channelInactive
19:58:53.700 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.7.154.125:39263(127.7.154.125:39263)] cleaning up while in state READY due to: connection closed
19:58:53.715 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
19:58:53.730 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)] handling channelInactive
19:58:53.730 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 7e5e79e42c9c41b69e02e5c87a6d3c05(127.7.154.65:36839)] cleaning up while in state READY due to: connection closed
19:58:53.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.730165  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 8063
19:58:53.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.751235  8190 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:53.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.864507  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 8063
19:58:53.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.889149  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 8202
19:58:53.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.910954  8327 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:53.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:53.999336  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 8202
19:58:54.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.018754  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 8339
19:58:54.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.025841  8461 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:54.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.121097  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 8339
19:58:54.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.138336  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 7796
19:58:54.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.139560  7857 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:54.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.247794  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 7796
19:58:54.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.268720  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 7866
19:58:54.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.269786  7928 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:54.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.371093  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 7866
19:58:54.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.386792  7785 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-task_vfL3T/build/asan/bin/kudu pid 7935
19:58:54.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.387907  7999 generic_service.cc:196] Checking for leaks (request via RPC)
19:58:54.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 19:58:54.497627  7785 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_vfL3T/build/asan/bin/kudu with pid 7935
19:58:54.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T19:58:54Z chronyd exiting

Time: 6.984

OK (1 test)

