JUnit version 4.13.2
.01:59:46.649 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779069586640
01:59:46.678 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
01:59:46.733 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
01:59:46.740 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskc2MSc3/test-tmp
01:59:46.748 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
01:59:46.751 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskc2MSc3/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
01:59:46.996 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

01:59:47.143 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
01:59:47.144 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

01:59:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.147529 13315 mini_oidc.cc:150] Starting JWKS server
01:59:47.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.150518 13315 webserver.cc:533] Webserver started at http://127.0.0.1:43253/ using document root <none> and password file <none>
01:59:47.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.150759 13315 mini_oidc.cc:186] Starting OIDC Discovery server
01:59:47.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.151901 13315 webserver.cc:533] Webserver started at http://127.0.0.1:40003/ using document root <none> and password file <none>
01:59:47.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T01:59:47Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
01:59:47.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T01:59:47Z Disabled control of system clock
01:59:47.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.181131 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:47.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:47.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal
01:59:47.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data
01:59:47.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:47.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:47.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:47.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:47.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:47.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:47.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/logs
01:59:47.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data/info.pb
01:59:47.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:47.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:47.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:47.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:47.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
01:59:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:47.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:47.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.254:45455
01:59:47.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.254
01:59:47.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:47.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:47.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:47.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:47.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:47.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:47.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:47.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:47.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json with env {}
01:59:47.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.517882 13327 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:47.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.518280 13327 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:47.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.518393 13327 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:47.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527469 13327 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
01:59:47.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527603 13327 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:47.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527686 13327 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
01:59:47.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527743 13327 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
01:59:47.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527817 13327 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
01:59:47.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.527870 13327 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43253/jwks.json
01:59:47.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.538754 13327 master_runner.cc:387] Master server non-default flags:
01:59:47.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:47.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:47.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:47.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:47.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data
01:59:47.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal
01:59:47.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:47.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:47.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:47.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:47.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:47.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.254:45455
01:59:47.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:47.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:47.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:47.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json
01:59:47.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:47.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:47.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data/info.pb
01:59:47.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.254
01:59:47.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:47.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:47.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:47.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:47.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:47.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:47.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/logs
01:59:47.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:47.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:47.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:47.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
01:59:47.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:47.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:47.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:47.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:47.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:47.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:47.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.541082 13327 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:47.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.543622 13327 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:47.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.554514 13327 server_base.cc:1061] running on GCE node
01:59:47.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.554497 13332 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
01:59:47.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.554591 13333 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
01:59:47.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.554747 13335 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
01:59:47.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.556068 13327 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:47.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.557844 13327 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:47.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.559128 13327 hybrid_clock.cc:648] HybridClock initialized: now 1779069587559058 us; error 61 us; skew 500 ppm
01:59:47.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.559592 13327 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:47.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.562134 13327 webserver.cc:533] Webserver started at http://127.13.0.254:42633/ using document root <none> and password file <none>
01:59:47.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.563038 13327 fs_manager.cc:362] Metadata directory not provided
01:59:47.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.563174 13327 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:47.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.563652 13327 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:47.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.566259 13327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data/instance:
01:59:47.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1e97bdc00699454292b1a31a5bcc5da3"
01:59:47.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:47 on dist-test-slave-svnz"
01:59:47.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.567273 13327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal/instance:
01:59:47.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1e97bdc00699454292b1a31a5bcc5da3"
01:59:47.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:47 on dist-test-slave-svnz"
01:59:47.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.572986 13327 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.001s
01:59:47.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.576494 13341 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:47.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.577978 13327 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
01:59:47.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.578167 13327 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal
01:59:47.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1e97bdc00699454292b1a31a5bcc5da3"
01:59:47.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:47 on dist-test-slave-svnz"
01:59:47.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.578387 13327 fs_report.cc:389] FS layout report
01:59:47.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:47.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal
01:59:47.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal
01:59:47.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data/data
01:59:47.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:47.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:47.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:47.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:47.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:47.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:47.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:47.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:47.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:47.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:47.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:47.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.601780 13327 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:47.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.602926 13327 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:47.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.603267 13327 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:47.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.625144 13327 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.254:45455
01:59:47.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.625180 13392 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.254:45455 every 8 connection(s)
01:59:47.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.627104 13327 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/data/info.pb
01:59:47.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.631719 13393 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:47.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.634701 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13327
01:59:47.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.635041 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-0/wal/instance
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.638075 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:47.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:47.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:47.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:47.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:47.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/logs
01:59:47.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data/info.pb
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:47.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.253:42495
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.253
01:59:47.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:47.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:47.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:47.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:47.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:47.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:47.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:47.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:47.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json with env {}
01:59:47.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.639392 13393 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } has no permanent_uuid. Determining permanent_uuid...
01:59:47.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.665303 13393 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } has no permanent_uuid. Determining permanent_uuid...
01:59:47.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.666745 13345 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:47.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.668522 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.253:42495: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:47.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.717963 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } attempt: 1
01:59:47.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.720252 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.253:42495: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:47.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.788539 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } attempt: 2
01:59:47.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.791070 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.253:42495: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:47.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:47.882359 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } attempt: 3
01:59:47.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.887293 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.253:42495: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:47.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.986153 13395 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:47.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.986465 13395 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:47.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.986541 13395 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:47.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995061 13395 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
01:59:47.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995162 13395 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:47.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995215 13395 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
01:59:47.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995257 13395 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
01:59:47.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995314 13395 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
01:59:47.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:47.995347 13395 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43253/jwks.json
01:59:48.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.011358 13395 master_runner.cc:387] Master server non-default flags:
01:59:48.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:48.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:48.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:48.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.253:42495
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:48.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data/info.pb
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.253
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:48.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/logs
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:48.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
01:59:48.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:48.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:48.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:48.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:48.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:48.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:48.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.013646 13395 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:48.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.016072 13395 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:48.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.025642 13404 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
01:59:48.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.026175 13406 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
01:59:48.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.025651 13403 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
01:59:48.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.027197 13395 server_base.cc:1061] running on GCE node
01:59:48.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.028179 13395 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:48.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.030023 13395 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:48.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.030544 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } attempt: 4
01:59:48.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.031268 13395 hybrid_clock.cc:648] HybridClock initialized: now 1779069588031197 us; error 58 us; skew 500 ppm
01:59:48.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.031697 13395 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:48.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.032811 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.253:42495: Network error: Client connection negotiation failed: client connection to 127.13.0.253:42495: connect: Connection refused (error 111)
01:59:48.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.034638 13395 webserver.cc:533] Webserver started at http://127.13.0.253:42311/ using document root <none> and password file <none>
01:59:48.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.035632 13395 fs_manager.cc:362] Metadata directory not provided
01:59:48.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.035777 13395 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:48.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.036243 13395 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:48.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.038789 13395 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data/instance:
01:59:48.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3aca63927f4f4f04b1e3bb927bd061fd"
01:59:48.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.039769 13395 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal/instance:
01:59:48.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3aca63927f4f4f04b1e3bb927bd061fd"
01:59:48.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.045512 13395 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.000s
01:59:48.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.049118 13412 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:48.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.050529 13395 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.002s
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.050751 13395 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3aca63927f4f4f04b1e3bb927bd061fd"
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.050998 13395 fs_report.cc:389] FS layout report
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:48.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data/data
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:48.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:48.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:48.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:48.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:48.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:48.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:48.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:48.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.081606 13395 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:48.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.082677 13395 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:48.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.082998 13395 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:48.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.104310 13395 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.253:42495
01:59:48.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.104331 13463 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.253:42495 every 8 connection(s)
01:59:48.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.106158 13395 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/data/info.pb
01:59:48.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.110741 13464 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:48.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.111545 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13395
01:59:48.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.111723 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-1/wal/instance
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.112902 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:48.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/logs
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data/info.pb
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:48.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:48.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.252:38835
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.252
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:48.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:48.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json with env {}
01:59:48.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.118008 13464 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.134905 13464 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.144953 13464 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.146122 13413 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.148736 13464 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.198084 13464 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 1
01:59:48.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.200336 13464 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.268671 13464 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 2
01:59:48.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.270879 13464 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.332113 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } attempt: 5
01:59:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.338539 13393 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.340358 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.362191 13464 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 3
01:59:48.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.364379 13464 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.391610 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 1
01:59:48.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.393759 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.460067 13466 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:48.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.460397 13466 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:48.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.460475 13466 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:48.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.462023 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 2
01:59:48.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.464138 13393 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471583 13466 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
01:59:48.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471698 13466 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:48.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471768 13466 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
01:59:48.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471817 13466 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
01:59:48.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471884 13466 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
01:59:48.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.471927 13466 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:43253/jwks.json
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.482772 13466 master_runner.cc:387] Master server non-default flags:
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:48.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:48.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.252:38835
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43253/jwks.json
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data/info.pb
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.252
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/logs
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:48.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:48.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:48.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:48.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.484817 13466 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:48.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.487282 13466 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.496022 13474 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
01:59:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.496064 13475 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
01:59:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.496289 13477 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
01:59:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.497532 13466 server_base.cc:1061] running on GCE node
01:59:48.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.498304 13466 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.499686 13466 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.500900 13466 hybrid_clock.cc:648] HybridClock initialized: now 1779069588500828 us; error 55 us; skew 500 ppm
01:59:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.501227 13466 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:48.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.503404 13466 webserver.cc:533] Webserver started at http://127.13.0.252:44567/ using document root <none> and password file <none>
01:59:48.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.504087 13466 fs_manager.cc:362] Metadata directory not provided
01:59:48.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.504194 13466 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:48.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.504472 13466 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.506778 13466 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data/instance:
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7029c7f7c3140d094fe0aecd3d8095f"
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.507572 13466 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal/instance:
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7029c7f7c3140d094fe0aecd3d8095f"
01:59:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.507629 13464 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 4
01:59:48.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.509581 13464 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.0.252:38835: Network error: Client connection negotiation failed: client connection to 127.13.0.252:38835: connect: Connection refused (error 111)
01:59:48.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.513217 13466 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.003s	sys 0.004s
01:59:48.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.516458 13483 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.517839 13466 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.517987 13466 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e7029c7f7c3140d094fe0aecd3d8095f"
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:48 on dist-test-slave-svnz"
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.518134 13466 fs_report.cc:389] FS layout report
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data/data
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:48.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:48.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:48.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:48.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:48.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:48.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.541424 13466 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:48.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.542271 13466 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:48.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.542575 13466 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.562939 13466 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.252:38835
01:59:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.562916 13534 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.252:38835 every 8 connection(s)
01:59:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.564693 13466 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/data/info.pb
01:59:48.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.568929 13535 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:48.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.570369 13393 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 3
01:59:48.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.573115 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13466
01:59:48.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.573314 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/master-2/wal/instance
01:59:48.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.577392 13535 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.588510 13393 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: Bootstrap starting.
01:59:48.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.592453 13535 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.593221 13393 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: Neither blocks nor log segments found. Creating new log.
01:59:48.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.594995 13393 log.cc:826] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: Log is configured to *not* fsync() on all Append() calls
01:59:48.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.598981 13393 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: No bootstrap required, opened a new log
01:59:48.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.600459 13535 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } has no permanent_uuid. Determining permanent_uuid...
01:59:48.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.606969 13393 raft_consensus.cc:359] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.607326 13393 raft_consensus.cc:385] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:48.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.607472 13393 raft_consensus.cc:740] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1e97bdc00699454292b1a31a5bcc5da3, State: Initialized, Role: FOLLOWER
01:59:48.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.608328 13393 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.611960 13535 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f: Bootstrap starting.
01:59:48.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.613190 13544 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.613507 13544 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.614319 13393 sys_catalog.cc:565] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: configured and running, proceeding with master startup.
01:59:48.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.615433 13535 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f: Neither blocks nor log segments found. Creating new log.
01:59:48.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.616838 13535 log.cc:826] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f: Log is configured to *not* fsync() on all Append() calls
01:59:48.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.622586 13535 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f: No bootstrap required, opened a new log
01:59:48.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.637604 13535 raft_consensus.cc:359] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.638535 13535 raft_consensus.cc:385] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:48.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.638999 13535 raft_consensus.cc:740] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e7029c7f7c3140d094fe0aecd3d8095f, State: Initialized, Role: FOLLOWER
01:59:48.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.639578 13556 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
01:59:48.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:48.639974 13556 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
01:59:48.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.640065 13535 consensus_queue.cc:260] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.634326 13327 master_runner.cc:187] Error getting master registration for 127.13.0.253:42495: OK, instance_id { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" instance_seqno: 1779069588098555 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
01:59:48.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.641166 13327 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
01:59:48.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.645318 13558 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.646098 13558 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.646847 13535 sys_catalog.cc:565] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: configured and running, proceeding with master startup.
01:59:48.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.648761 13558 raft_consensus.cc:493] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
01:59:48.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.650470 13558 raft_consensus.cc:515] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.660179 13558 leader_election.cc:290] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 1e97bdc00699454292b1a31a5bcc5da3 (127.13.0.254:45455), 3aca63927f4f4f04b1e3bb927bd061fd (127.13.0.253:42495)
01:59:48.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.659444 13368 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1e97bdc00699454292b1a31a5bcc5da3" is_pre_election: true
01:59:48.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.661091 13368 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e7029c7f7c3140d094fe0aecd3d8095f in term 0.
01:59:48.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.661798 13484 leader_election.cc:304] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [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: 1e97bdc00699454292b1a31a5bcc5da3, e7029c7f7c3140d094fe0aecd3d8095f; no voters: 
01:59:48.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.663865 13558 raft_consensus.cc:2804] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Leader pre-election won for term 1
01:59:48.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.664350 13558 raft_consensus.cc:493] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
01:59:48.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.664731 13558 raft_consensus.cc:3060] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 0 FOLLOWER]: Advancing to term 1
01:59:48.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.669620 13558 raft_consensus.cc:515] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.670653 13558 leader_election.cc:290] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [CANDIDATE]: Term 1 election: Requested vote from peers 1e97bdc00699454292b1a31a5bcc5da3 (127.13.0.254:45455), 3aca63927f4f4f04b1e3bb927bd061fd (127.13.0.253:42495)
01:59:48.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.673691 13368 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1e97bdc00699454292b1a31a5bcc5da3"
01:59:48.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.673880 13368 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 0 FOLLOWER]: Advancing to term 1
01:59:48.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.677556 13368 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e7029c7f7c3140d094fe0aecd3d8095f in term 1.
01:59:48.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.678299 13484 leader_election.cc:304] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [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: 1e97bdc00699454292b1a31a5bcc5da3, e7029c7f7c3140d094fe0aecd3d8095f; no voters: 
01:59:48.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.678674 13558 raft_consensus.cc:2804] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 1 FOLLOWER]: Leader election won for term 1
01:59:48.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.679759 13558 raft_consensus.cc:697] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [term 1 LEADER]: Becoming Leader. State: Replica: e7029c7f7c3140d094fe0aecd3d8095f, State: Running, Role: LEADER
01:59:48.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.680369 13558 consensus_queue.cc:237] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.684540 13564 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: SysCatalogTable state changed. Reason: New leader e7029c7f7c3140d094fe0aecd3d8095f. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.685204 13564 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: This master's current role is: LEADER
01:59:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.687057 13568 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
01:59:48.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.692948 13568 catalog_manager.cc:1519] Initializing Kudu cluster ID...
01:59:48.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.704252 13466 master_runner.cc:187] Error getting master registration for 127.13.0.253:42495: OK, instance_id { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" instance_seqno: 1779069588098555 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
01:59:48.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.710800 13466 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
01:59:48.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.714396 13368 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [term 1 FOLLOWER]: Refusing update from remote peer e7029c7f7c3140d094fe0aecd3d8095f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
01:59:48.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.715495 13564 consensus_queue.cc:1048] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [LEADER]: Connected to new peer: Peer: permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
01:59:48.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.734110 13544 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: SysCatalogTable state changed. Reason: New leader e7029c7f7c3140d094fe0aecd3d8095f. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.734423 13544 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.738338 13544 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.738566 13544 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3 [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.738811 13574 mvcc.cc:204] Tried to move back new op lower bound from 7287069035359342592 to 7287069035240341504. Current Snapshot: MvccSnapshot[applied={T|T < 7287069035359342592}]
01:59:48.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.745388 13564 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.745675 13564 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: This master's current role is: LEADER
01:59:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.749696 13568 catalog_manager.cc:1382] Generated new cluster ID: 6e102e516bf84489820d28ee76e09d33
01:59:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.749827 13568 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
01:59:48.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.808811 13464 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } attempt: 5
01:59:48.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.831993 13464 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: Bootstrap starting.
01:59:48.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.836480 13568 catalog_manager.cc:1405] Generated new certificate authority record
01:59:48.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.841375 13464 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: Neither blocks nor log segments found. Creating new log.
01:59:48.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.842856 13568 catalog_manager.cc:1539] Loading token signing keys...
01:59:48.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.846746 13464 log.cc:826] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: Log is configured to *not* fsync() on all Append() calls
01:59:48.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.862484 13464 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: No bootstrap required, opened a new log
01:59:48.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.867805 13568 catalog_manager.cc:6069] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f: Generated new TSK 0
01:59:48.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.870808 13568 catalog_manager.cc:1549] Initializing in-progress tserver states...
01:59:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.875324 13464 raft_consensus.cc:359] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.875679 13464 raft_consensus.cc:385] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:48.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.875798 13464 raft_consensus.cc:740] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3aca63927f4f4f04b1e3bb927bd061fd, State: Initialized, Role: FOLLOWER
01:59:48.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.878415 13464 consensus_queue.cc:260] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } }
01:59:48.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.880460 13581 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [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: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.881453 13464 sys_catalog.cc:565] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: configured and running, proceeding with master startup.
01:59:48.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.881546 13439 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" is_pre_election: true
01:59:48.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.881810 13438 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3aca63927f4f4f04b1e3bb927bd061fd"
01:59:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.882400 13437 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [term 0 FOLLOWER]: Advancing to term 1
01:59:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.887228 13437 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [term 1 FOLLOWER]: Refusing update from remote peer e7029c7f7c3140d094fe0aecd3d8095f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
01:59:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.889037 13558 consensus_queue.cc:1048] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [LEADER]: Connected to new peer: Peer: permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
01:59:48.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.900405 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:48.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/logs
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data/info.pb
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.193:0
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.193
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.193
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
01:59:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.882563 13581 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.949112 13590 mvcc.cc:204] Tried to move back new op lower bound from 7287069035359342592 to 7287069035240341504. Current Snapshot: MvccSnapshot[applied={T|T < 7287069035359342592}]
01:59:48.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.968969 13581 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: SysCatalogTable state changed. Reason: New leader e7029c7f7c3140d094fe0aecd3d8095f. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.969239 13581 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.969978 13584 sys_catalog.cc:455] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:48.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.970297 13584 sys_catalog.cc:458] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd [sys.catalog]: This master's current role is: FOLLOWER
01:59:48.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.983414 13598 catalog_manager.cc:1294] Loaded cluster ID: 6e102e516bf84489820d28ee76e09d33
01:59:48.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.983947 13598 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: loading cluster ID for follower catalog manager: success
01:59:48.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:48.999179 13598 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: acquiring CA information for follower catalog manager: success
01:59:49.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.002782 13598 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 3aca63927f4f4f04b1e3bb927bd061fd: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
01:59:49.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.272382 13558 sys_catalog.cc:455] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1e97bdc00699454292b1a31a5bcc5da3" member_type: VOTER last_known_addr { host: "127.13.0.254" port: 45455 } } peers { permanent_uuid: "3aca63927f4f4f04b1e3bb927bd061fd" member_type: VOTER last_known_addr { host: "127.13.0.253" port: 42495 } } peers { permanent_uuid: "e7029c7f7c3140d094fe0aecd3d8095f" member_type: VOTER last_known_addr { host: "127.13.0.252" port: 38835 } } }
01:59:49.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.272699 13558 sys_catalog.cc:458] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f [sys.catalog]: This master's current role is: LEADER
01:59:49.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.389273 13587 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:49.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.389616 13587 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:49.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.389716 13587 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:49.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.398414 13587 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:49.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.398589 13587 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.0.193
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.408985 13587 tablet_server_runner.cc:78] Tablet server non-default flags:
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:49.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.193:0
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data/info.pb
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.193
01:59:49.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.193
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/logs
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
01:59:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:49.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.410821 13587 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:49.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.413350 13587 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:49.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.425380 13604 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
01:59:49.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.427312 13605 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
01:59:49.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.438591 13607 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
01:59:49.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.439309 13587 server_base.cc:1061] running on GCE node
01:59:49.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.440099 13587 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:49.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.441391 13587 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:49.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.442906 13587 hybrid_clock.cc:648] HybridClock initialized: now 1779069589442788 us; error 107 us; skew 500 ppm
01:59:49.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.443300 13587 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:49.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.446200 13587 webserver.cc:533] Webserver started at http://127.13.0.193:39311/ using document root <none> and password file <none>
01:59:49.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.447257 13587 fs_manager.cc:362] Metadata directory not provided
01:59:49.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.447399 13587 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:49.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.447804 13587 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:49.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.451139 13587 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data/instance:
01:59:49.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "917a64c734d447c9955619b8a8b128e7"
01:59:49.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.452128 13587 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal/instance:
01:59:49.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "917a64c734d447c9955619b8a8b128e7"
01:59:49.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.458303 13587 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.003s
01:59:49.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.461926 13613 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:49.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.463567 13587 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.001s
01:59:49.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.463708 13587 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal
01:59:49.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "917a64c734d447c9955619b8a8b128e7"
01:59:49.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.463886 13587 fs_report.cc:389] FS layout report
01:59:49.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:49.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data/data
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:49.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:49.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.481371 13587 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.482151 13587 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.482456 13587 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.483492 13587 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
01:59:49.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.485405 13587 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
01:59:49.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.485524 13587 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
01:59:49.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.485630 13587 ts_tablet_manager.cc:616] Registered 0 tablets
01:59:49.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.485710 13587 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
01:59:49.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.525490 13587 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.193:36941
01:59:49.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.525547 13725 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.193:36941 every 8 connection(s)
01:59:49.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.527908 13587 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/data/info.pb
01:59:49.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.532793 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13587
01:59:49.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.533046 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-0/wal/instance
01:59:49.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.543869 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:49.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:49.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/logs
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data/info.pb
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:49.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.194:0
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.194
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.194
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:49.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:49.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:49.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:49.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
01:59:49.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.569367 13728 heartbeater.cc:344] Connected to a master server at 127.13.0.253:42495
01:59:49.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.569640 13726 heartbeater.cc:344] Connected to a master server at 127.13.0.252:38835
01:59:49.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.569815 13726 heartbeater.cc:461] Registering TS with master...
01:59:49.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.569888 13727 heartbeater.cc:344] Connected to a master server at 127.13.0.254:45455
01:59:49.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.570022 13727 heartbeater.cc:461] Registering TS with master...
01:59:49.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.569821 13728 heartbeater.cc:461] Registering TS with master...
01:59:49.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.571106 13726 heartbeater.cc:507] Master 127.13.0.252:38835 requested a full tablet report, sending...
01:59:49.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.571213 13728 heartbeater.cc:507] Master 127.13.0.253:42495 requested a full tablet report, sending...
01:59:49.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.572244 13727 heartbeater.cc:507] Master 127.13.0.254:45455 requested a full tablet report, sending...
01:59:49.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.574002 13500 ts_manager.cc:194] Registered new tserver with Master: 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941)
01:59:49.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.574296 13429 ts_manager.cc:194] Registered new tserver with Master: 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941)
01:59:49.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.576191 13500 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.0.193:46779
01:59:49.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.577739 13358 ts_manager.cc:194] Registered new tserver with Master: 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941)
01:59:49.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.643199 13556 catalog_manager.cc:1294] Loaded cluster ID: 6e102e516bf84489820d28ee76e09d33
01:59:49.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.643312 13556 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: loading cluster ID for follower catalog manager: success
01:59:49.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.647394 13556 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: acquiring CA information for follower catalog manager: success
01:59:49.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.651082 13556 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 1e97bdc00699454292b1a31a5bcc5da3: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
01:59:49.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.908155 13734 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:49.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.908635 13734 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:49.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.908739 13734 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:49.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.918344 13734 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:49.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.918663 13734 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.0.194
01:59:49.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.929667 13734 tablet_server_runner.cc:78] Tablet server non-default flags:
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.194:0
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data/info.pb
01:59:49.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.194
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.194
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/logs
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:49.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.931221 13734 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:49.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.933063 13734 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:49.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.943001 13741 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
01:59:49.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.942950 13742 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
01:59:49.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:49.943037 13744 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
01:59:49.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.944023 13734 server_base.cc:1061] running on GCE node
01:59:49.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.944741 13734 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:49.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.945782 13734 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:49.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.947019 13734 hybrid_clock.cc:648] HybridClock initialized: now 1779069589946954 us; error 54 us; skew 500 ppm
01:59:49.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.947404 13734 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:49.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.949988 13734 webserver.cc:533] Webserver started at http://127.13.0.194:45937/ using document root <none> and password file <none>
01:59:49.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.950796 13734 fs_manager.cc:362] Metadata directory not provided
01:59:49.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.950937 13734 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:49.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.951413 13734 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:49.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.953879 13734 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data/instance:
01:59:49.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f5306c48fb9342e48e0c3c8244988cef"
01:59:49.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.954780 13734 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal/instance:
01:59:49.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f5306c48fb9342e48e0c3c8244988cef"
01:59:49.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.960232 13734 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.001s
01:59:49.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.963822 13750 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:49.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.965420 13734 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
01:59:49.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.965637 13734 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f5306c48fb9342e48e0c3c8244988cef"
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:49 on dist-test-slave-svnz"
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.965915 13734 fs_report.cc:389] FS layout report
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal
01:59:49.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data/data
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:49.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:49.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.986925 13734 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:49.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.987955 13734 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:49.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.988284 13734 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:49.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.989477 13734 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
01:59:49.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.991242 13734 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
01:59:49.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.991370 13734 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
01:59:49.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.991480 13734 ts_tablet_manager.cc:616] Registered 0 tablets
01:59:49.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:49.991559 13734 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
01:59:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.027530 13734 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.194:44339
01:59:50.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.027590 13862 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.194:44339 every 8 connection(s)
01:59:50.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.029222 13734 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/data/info.pb
01:59:50.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.030844 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13734
01:59:50.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.031050 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-1/wal/instance
01:59:50.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.039565 13315 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:50.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/logs
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data/info.pb
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:50.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.195:0
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.195
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.195
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:50.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
01:59:50.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.050526 13863 heartbeater.cc:344] Connected to a master server at 127.13.0.252:38835
01:59:50.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.050971 13863 heartbeater.cc:461] Registering TS with master...
01:59:50.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.052161 13863 heartbeater.cc:507] Master 127.13.0.252:38835 requested a full tablet report, sending...
01:59:50.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.052695 13865 heartbeater.cc:344] Connected to a master server at 127.13.0.253:42495
01:59:50.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.052861 13865 heartbeater.cc:461] Registering TS with master...
01:59:50.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.053391 13865 heartbeater.cc:507] Master 127.13.0.253:42495 requested a full tablet report, sending...
01:59:50.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.054368 13500 ts_manager.cc:194] Registered new tserver with Master: f5306c48fb9342e48e0c3c8244988cef (127.13.0.194:44339)
01:59:50.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.054981 13429 ts_manager.cc:194] Registered new tserver with Master: f5306c48fb9342e48e0c3c8244988cef (127.13.0.194:44339)
01:59:50.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.055414 13500 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.0.194:49707
01:59:50.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.056993 13864 heartbeater.cc:344] Connected to a master server at 127.13.0.254:45455
01:59:50.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.057170 13864 heartbeater.cc:461] Registering TS with master...
01:59:50.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.057696 13864 heartbeater.cc:507] Master 127.13.0.254:45455 requested a full tablet report, sending...
01:59:50.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.060927 13358 ts_manager.cc:194] Registered new tserver with Master: f5306c48fb9342e48e0c3c8244988cef (127.13.0.194:44339)
01:59:50.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.377488 13870 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
01:59:50.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.377794 13870 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
01:59:50.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.377864 13870 flags.cc:432] Enabled unsafe flag: --never_fsync=true
01:59:50.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.387564 13870 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
01:59:50.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.387849 13870 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.0.195
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.398160 13870 tablet_server_runner.cc:78] Tablet server non-default flags:
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.0.212:45961
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
01:59:50.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.0.195:0
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data/info.pb
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.0.195
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.0.254:45455,127.13.0.253:42495,127.13.0.252:38835
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.0.195
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/logs
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on bdcb31816ec0
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11950
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
01:59:50.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.399816 13870 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
01:59:50.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.401623 13870 file_cache.cc:492] Constructed file cache file cache with capacity 419430
01:59:50.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.413190 13875 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
01:59:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.413149 13876 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
01:59:50.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:50.414430 13878 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
01:59:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.415048 13870 server_base.cc:1061] running on GCE node
01:59:50.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.415805 13870 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
01:59:50.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.417109 13870 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
01:59:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.418357 13870 hybrid_clock.cc:648] HybridClock initialized: now 1779069590418280 us; error 65 us; skew 500 ppm
01:59:50.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.418749 13870 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
01:59:50.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.421548 13870 webserver.cc:533] Webserver started at http://127.13.0.195:32817/ using document root <none> and password file <none>
01:59:50.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.422513 13870 fs_manager.cc:362] Metadata directory not provided
01:59:50.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.422653 13870 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
01:59:50.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.423043 13870 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.425981 13870 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data/instance:
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "71f4805d8c3d44e3b8d856d26d77bdcd"
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:50 on dist-test-slave-svnz"
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.426702 13870 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal/instance:
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "71f4805d8c3d44e3b8d856d26d77bdcd"
01:59:50.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:50 on dist-test-slave-svnz"
01:59:50.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.431787 13870 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
01:59:50.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.435127 13884 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
01:59:50.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.436748 13870 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.436892 13870 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data,/tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "71f4805d8c3d44e3b8d856d26d77bdcd"
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 01:59:50 on dist-test-slave-svnz"
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.437068 13870 fs_report.cc:389] FS layout report
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data/data
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
01:59:50.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
01:59:50.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.455355 13870 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
01:59:50.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.456115 13870 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
01:59:50.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.456346 13870 kserver.cc:163] Server-wide thread pool size limit: 3276
01:59:50.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.457391 13870 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
01:59:50.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.458976 13870 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
01:59:50.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.459057 13870 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
01:59:50.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.459125 13870 ts_tablet_manager.cc:616] Registered 0 tablets
01:59:50.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.459172 13870 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
01:59:50.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.493252 13870 rpc_server.cc:307] RPC server started. Bound to: 127.13.0.195:37409
01:59:50.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.493347 13996 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.0.195:37409 every 8 connection(s)
01:59:50.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.494755 13870 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/data/info.pb
01:59:50.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.500677 13315 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu as pid 13870
01:59:50.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.500867 13315 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskc2MSc3/test-tmp/mini-kudu-cluster3767423925737907378/ts-2/wal/instance
01:59:50.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.512673 13999 heartbeater.cc:344] Connected to a master server at 127.13.0.253:42495
01:59:50.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.512706 13998 heartbeater.cc:344] Connected to a master server at 127.13.0.254:45455
01:59:50.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.513140 13999 heartbeater.cc:461] Registering TS with master...
01:59:50.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.513145 13998 heartbeater.cc:461] Registering TS with master...
01:59:50.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.513315 13997 heartbeater.cc:344] Connected to a master server at 127.13.0.252:38835
01:59:50.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.513419 13997 heartbeater.cc:461] Registering TS with master...
01:59:50.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.514335 13997 heartbeater.cc:507] Master 127.13.0.252:38835 requested a full tablet report, sending...
01:59:50.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.514374 13999 heartbeater.cc:507] Master 127.13.0.253:42495 requested a full tablet report, sending...
01:59:50.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.515570 13998 heartbeater.cc:507] Master 127.13.0.254:45455 requested a full tablet report, sending...
01:59:50.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.515990 13500 ts_manager.cc:194] Registered new tserver with Master: 71f4805d8c3d44e3b8d856d26d77bdcd (127.13.0.195:37409)
01:59:50.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.516103 13429 ts_manager.cc:194] Registered new tserver with Master: 71f4805d8c3d44e3b8d856d26d77bdcd (127.13.0.195:37409)
01:59:50.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.516619 13358 ts_manager.cc:194] Registered new tserver with Master: 71f4805d8c3d44e3b8d856d26d77bdcd (127.13.0.195:37409)
01:59:50.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.517005 13500 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.0.195:46721
01:59:50.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.530596 13315 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
01:59:50.532 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
01:59:50.534 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

01:59:50.543 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.0.254"
      port: 45455
    }
    bound_http_address {
      host: "127.13.0.254"
      port: 42633
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.0.253"
      port: 42495
    }
    bound_http_address {
      host: "127.13.0.253"
      port: 42311
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.0.252"
      port: 38835
    }
    bound_http_address {
      host: "127.13.0.252"
      port: 44567
    }
  }
}

01:59:50.546 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

01:59:50.549 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.0.193"
      port: 36941
    }
    bound_http_address {
      host: "127.13.0.193"
      port: 39311
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.0.194"
      port: 44339
    }
    bound_http_address {
      host: "127.13.0.194"
      port: 45937
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.0.195"
      port: 37409
    }
    bound_http_address {
      host: "127.13.0.195"
      port: 32817
    }
  }
}

01:59:50.549 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
01:59:50.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:50.579329 13726 heartbeater.cc:499] Master 127.13.0.252:38835 was elected leader, sending a full tablet report...
01:59:50.715 [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)
01:59:50.771 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
01:59:50.918 [DEBUG - main] (Connection.java:748) [peer master-127.13.0.252:38835(127.13.0.252:38835)] connecting to peer
01:59:50.965 [DEBUG - main] (Connection.java:748) [peer master-127.13.0.254:45455(127.13.0.254:45455)] connecting to peer
01:59:50.974 [DEBUG - main] (Connection.java:748) [peer master-127.13.0.253:42495(127.13.0.253:42495)] connecting to peer
01:59:50.984 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.13.0.254:45455(127.13.0.254:45455)] Successfully connected to peer
01:59:50.984 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.0.252:38835(127.13.0.252:38835)] Successfully connected to peer
01:59:50.984 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.13.0.253:42495(127.13.0.253:42495)] Successfully connected to peer
01:59:51.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.060015 13863 heartbeater.cc:499] Master 127.13.0.252:38835 was elected leader, sending a full tablet report...
01:59:51.071 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.0.252
01:59:51.073 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.0.253
01:59:51.077 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.13.0.254
01:59:51.287 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xa2e6bbd2, L:/127.0.0.1:55228 - R:/127.13.0.253:42495] using SASL/PLAIN
01:59:51.287 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xaf29327c, L:/127.0.0.1:44842 - R:/127.13.0.252:38835] using SASL/PLAIN
01:59:51.287 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x8e86728a, L:/127.0.0.1:42832 - R:/127.13.0.254:45455] using SASL/PLAIN
01:59:51.324 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
01:59:51.325 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=442), Traces: [0ms] refreshing cache from master, [22ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.0.252:38835, [79ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.0.254:45455, [88ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.0.253:42495, [415ms] Sub RPC ConnectToMaster: received response from server master-127.13.0.253:42495: OK, [415ms] Sub RPC ConnectToMaster: received response from server master-127.13.0.254:45455: OK, [416ms] Sub RPC ConnectToMaster: received response from server master-127.13.0.252:38835: OK, deferred=null) after lookup
01:59:51.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.372725 13500 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:44842:
01:59:51.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1779069586533"
01:59:51.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
01:59:51.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
01:59:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
01:59:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
01:59:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
01:59:51.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:51.374632 13500 catalog_manager.cc:7058] 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-1779069586533 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
01:59:51.421 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 81ff75ea77a0436489b2ba3f60208512
01:59:51.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.427794 13932 tablet_service.cc:1511] Processing CreateTablet for tablet 70cc35cd5fa9453abe75ab6c60440dc8 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069586533 [id=81ff75ea77a0436489b2ba3f60208512]), partition=RANGE (key) PARTITION UNBOUNDED
01:59:51.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.429759 13932 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 70cc35cd5fa9453abe75ab6c60440dc8. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:51.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.430501 13798 tablet_service.cc:1511] Processing CreateTablet for tablet 70cc35cd5fa9453abe75ab6c60440dc8 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069586533 [id=81ff75ea77a0436489b2ba3f60208512]), partition=RANGE (key) PARTITION UNBOUNDED
01:59:51.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.431490 13661 tablet_service.cc:1511] Processing CreateTablet for tablet 70cc35cd5fa9453abe75ab6c60440dc8 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069586533 [id=81ff75ea77a0436489b2ba3f60208512]), partition=RANGE (key) PARTITION UNBOUNDED
01:59:51.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.432085 13798 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 70cc35cd5fa9453abe75ab6c60440dc8. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:51.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.432789 13661 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 70cc35cd5fa9453abe75ab6c60440dc8. 1 dirs total, 0 dirs full, 0 dirs failed
01:59:51.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.441313 14026 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Bootstrap starting.
01:59:51.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.442708 14027 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Bootstrap starting.
01:59:51.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.445318 14026 tablet_bootstrap.cc:654] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Neither blocks nor log segments found. Creating new log.
01:59:51.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.446415 14027 tablet_bootstrap.cc:654] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Neither blocks nor log segments found. Creating new log.
01:59:51.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.446846 14026 log.cc:826] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Log is configured to *not* fsync() on all Append() calls
01:59:51.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.447891 14027 log.cc:826] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Log is configured to *not* fsync() on all Append() calls
01:59:51.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.451222 14028 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Bootstrap starting.
01:59:51.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.457144 14028 tablet_bootstrap.cc:654] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Neither blocks nor log segments found. Creating new log.
01:59:51.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.459331 14028 log.cc:826] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Log is configured to *not* fsync() on all Append() calls
01:59:51.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.459946 14027 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: No bootstrap required, opened a new log
01:59:51.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.460623 14026 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: No bootstrap required, opened a new log
01:59:51.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.460644 14027 ts_tablet_manager.cc:1403] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Time spent bootstrapping tablet: real 0.018s	user 0.005s	sys 0.011s
01:59:51.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.462793 14026 ts_tablet_manager.cc:1403] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Time spent bootstrapping tablet: real 0.022s	user 0.007s	sys 0.004s
01:59:51.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.469168 14027 raft_consensus.cc:359] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.469537 14027 raft_consensus.cc:385] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:51.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.469645 14027 raft_consensus.cc:740] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 71f4805d8c3d44e3b8d856d26d77bdcd, State: Initialized, Role: FOLLOWER
01:59:51.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.470363 14027 consensus_queue.cc:260] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [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: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.471587 13997 heartbeater.cc:499] Master 127.13.0.252:38835 was elected leader, sending a full tablet report...
01:59:51.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.472874 14028 tablet_bootstrap.cc:492] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: No bootstrap required, opened a new log
01:59:51.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.473325 14028 ts_tablet_manager.cc:1403] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Time spent bootstrapping tablet: real 0.022s	user 0.008s	sys 0.005s
01:59:51.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.474756 14026 raft_consensus.cc:359] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.475311 14026 raft_consensus.cc:385] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:51.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.475438 14026 raft_consensus.cc:740] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f5306c48fb9342e48e0c3c8244988cef, State: Initialized, Role: FOLLOWER
01:59:51.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.476136 14026 consensus_queue.cc:260] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [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: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.476655 14027 ts_tablet_manager.cc:1434] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Time spent starting tablet: real 0.016s	user 0.009s	sys 0.002s
01:59:51.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.480384 14028 raft_consensus.cc:359] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.481232 14026 ts_tablet_manager.cc:1434] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Time spent starting tablet: real 0.018s	user 0.012s	sys 0.000s
01:59:51.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.481607 14028 raft_consensus.cc:385] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
01:59:51.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.481899 14028 raft_consensus.cc:740] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 917a64c734d447c9955619b8a8b128e7, State: Initialized, Role: FOLLOWER
01:59:51.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.482721 14028 consensus_queue.cc:260] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [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: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.486258 14028 ts_tablet_manager.cc:1434] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Time spent starting tablet: real 0.013s	user 0.009s	sys 0.000s
01:59:51.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:51.498638 14000 tablet.cc:2404] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd: Can't schedule compaction. Clean time has not been advanced past its initial value.
01:59:51.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:51.532778 13729 tablet.cc:2404] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7: Can't schedule compaction. Clean time has not been advanced past its initial value.
01:59:51.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:51.538609 13866 tablet.cc:2404] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef: Can't schedule compaction. Clean time has not been advanced past its initial value.
01:59:51.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.573071 14032 raft_consensus.cc:493] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
01:59:51.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.573312 14032 raft_consensus.cc:515] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.575013 14032 leader_election.cc:290] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers f5306c48fb9342e48e0c3c8244988cef (127.13.0.194:44339), 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941)
01:59:51.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.583927 13681 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "70cc35cd5fa9453abe75ab6c60440dc8" candidate_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "917a64c734d447c9955619b8a8b128e7" is_pre_election: true
01:59:51.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.584255 13818 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "70cc35cd5fa9453abe75ab6c60440dc8" candidate_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f5306c48fb9342e48e0c3c8244988cef" is_pre_election: true
01:59:51.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.584442 13681 raft_consensus.cc:2468] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 71f4805d8c3d44e3b8d856d26d77bdcd in term 0.
01:59:51.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.584713 13818 raft_consensus.cc:2468] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 71f4805d8c3d44e3b8d856d26d77bdcd in term 0.
01:59:51.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.585187 13888 leader_election.cc:304] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [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: 71f4805d8c3d44e3b8d856d26d77bdcd, 917a64c734d447c9955619b8a8b128e7; no voters: 
01:59:51.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.585538 14032 raft_consensus.cc:2804] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Leader pre-election won for term 1
01:59:51.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.585705 14032 raft_consensus.cc:493] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
01:59:51.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.585803 14032 raft_consensus.cc:3060] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 0 FOLLOWER]: Advancing to term 1
01:59:51.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.588095 14032 raft_consensus.cc:515] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.588680 14032 leader_election.cc:290] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [CANDIDATE]: Term 1 election: Requested vote from peers f5306c48fb9342e48e0c3c8244988cef (127.13.0.194:44339), 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941)
01:59:51.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.589118 13818 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "70cc35cd5fa9453abe75ab6c60440dc8" candidate_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f5306c48fb9342e48e0c3c8244988cef"
01:59:51.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.589145 13681 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "70cc35cd5fa9453abe75ab6c60440dc8" candidate_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "917a64c734d447c9955619b8a8b128e7"
01:59:51.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.589287 13681 raft_consensus.cc:3060] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 0 FOLLOWER]: Advancing to term 1
01:59:51.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.589308 13818 raft_consensus.cc:3060] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 0 FOLLOWER]: Advancing to term 1
01:59:51.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.591393 13681 raft_consensus.cc:2468] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 71f4805d8c3d44e3b8d856d26d77bdcd in term 1.
01:59:51.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.591681 13818 raft_consensus.cc:2468] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 71f4805d8c3d44e3b8d856d26d77bdcd in term 1.
01:59:51.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.591751 13888 leader_election.cc:304] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [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: 71f4805d8c3d44e3b8d856d26d77bdcd, 917a64c734d447c9955619b8a8b128e7; no voters: 
01:59:51.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.592023 14032 raft_consensus.cc:2804] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 1 FOLLOWER]: Leader election won for term 1
01:59:51.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.592535 14032 raft_consensus.cc:697] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [term 1 LEADER]: Becoming Leader. State: Replica: 71f4805d8c3d44e3b8d856d26d77bdcd, State: Running, Role: LEADER
01:59:51.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.593286 14032 consensus_queue.cc:237] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [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: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } }
01:59:51.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.598428 13499 catalog_manager.cc:5696] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd reported cstate change: term changed from 0 to 1, leader changed from <none> to 71f4805d8c3d44e3b8d856d26d77bdcd (127.13.0.195). New cstate: current_term: 1 leader_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "71f4805d8c3d44e3b8d856d26d77bdcd" member_type: VOTER last_known_addr { host: "127.13.0.195" port: 37409 } health_report { overall_health: HEALTHY } } }
01:59:51.665 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 70cc35cd5fa9453abe75ab6c60440dc8 for table 'org.apache.kudu.client.TestHybridTime-1779069586533' with partition [<start>, <end>)
01:59:51.673 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=70cc35cd5fa9453abe75ab6c60440dc8@[71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)[L],917a64c734d447c9955619b8a8b128e7(127.13.0.193:36941),f5306c48fb9342e48e0c3c8244988cef(127.13.0.194:44339)]}]
01:59:51.675 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=21), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.13.0.252:38835, [9ms] Sub RPC GetTableLocations: received response from server master-127.13.0.252:38835: OK, deferred=null) after lookup
01:59:51.695 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)] connecting to peer
01:59:51.703 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)] Successfully connected to peer
01:59:51.761 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x565aa607, L:/127.0.0.1:50308 - R:/127.13.0.195:37409] using TOKEN/null
01:59:51.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.772095 13818 raft_consensus.cc:1275] T 70cc35cd5fa9453abe75ab6c60440dc8 P f5306c48fb9342e48e0c3c8244988cef [term 1 FOLLOWER]: Refusing update from remote peer 71f4805d8c3d44e3b8d856d26d77bdcd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
01:59:51.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.772116 13681 raft_consensus.cc:1275] T 70cc35cd5fa9453abe75ab6c60440dc8 P 917a64c734d447c9955619b8a8b128e7 [term 1 FOLLOWER]: Refusing update from remote peer 71f4805d8c3d44e3b8d856d26d77bdcd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
01:59:51.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.773221 14037 consensus_queue.cc:1048] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [LEADER]: Connected to new peer: Peer: permanent_uuid: "f5306c48fb9342e48e0c3c8244988cef" member_type: VOTER last_known_addr { host: "127.13.0.194" port: 44339 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
01:59:51.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.773490 14032 consensus_queue.cc:1048] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd [LEADER]: Connected to new peer: Peer: permanent_uuid: "917a64c734d447c9955619b8a8b128e7" member_type: VOTER last_known_addr { host: "127.13.0.193" port: 36941 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
01:59:51.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.801745 14042 mvcc.cc:204] Tried to move back new op lower bound from 7287069047886581760 to 7287069047169978368. Current Snapshot: MvccSnapshot[applied={T|T < 7287069047886581760}]
01:59:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:51.830586 14043 mvcc.cc:204] Tried to move back new op lower bound from 7287069047886581760 to 7287069047169978368. Current Snapshot: MvccSnapshot[applied={T|T < 7287069047886581760 or (T in {7287069047886581760})}]
01:59:51.863 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.880 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.888 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.891 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@999035250(state=PENDING, result=null, callback=<none>, errback=<none>)}
01:59:51.902 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.903 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@116065663(state=PENDING, result=null, callback=<none>, errback=<none>)}
01:59:51.910 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.911 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@446568444(state=PENDING, result=null, callback=<none>, errback=<none>)}
01:59:51.919 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
01:59:51.972 [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-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:51.981 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7287069068366581761) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:51.988 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7287069068366581765) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:51.994 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7287069068366581769) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:52.000 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7287069068366581773) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:52.006 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7287069068366581777) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:52.012 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7287069068366581781) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:52.018 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7287069068366581782) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069586533, tablet=70cc35cd5fa9453abe75ab6c60440dc8, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
01:59:52.021 [DEBUG - main] (Connection.java:575) [peer master-127.13.0.254:45455(127.13.0.254:45455)] disconnecting while in state READY
01:59:52.022 [DEBUG - main] (Connection.java:575) [peer master-127.13.0.253:42495(127.13.0.253:42495)] disconnecting while in state READY
01:59:52.022 [DEBUG - main] (Connection.java:575) [peer master-127.13.0.252:38835(127.13.0.252:38835)] disconnecting while in state READY
01:59:52.023 [DEBUG - main] (Connection.java:575) [peer 71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)] disconnecting while in state READY
01:59:52.027 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)] handling channelInactive
01:59:52.028 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 71f4805d8c3d44e3b8d856d26d77bdcd(127.13.0.195:37409)] cleaning up while in state READY due to: connection closed
01:59:52.028 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.0.252:38835(127.13.0.252:38835)] handling channelInactive
01:59:52.029 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.0.252:38835(127.13.0.252:38835)] cleaning up while in state READY due to: connection closed
01:59:52.032 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.13.0.254:45455(127.13.0.254:45455)] handling channelInactive
01:59:52.033 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
01:59:52.041 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.13.0.254:45455(127.13.0.254:45455)] cleaning up while in state READY due to: connection closed
01:59:52.055 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.13.0.253:42495(127.13.0.253:42495)] handling channelInactive
01:59:52.055 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.13.0.253:42495(127.13.0.253:42495)] cleaning up while in state READY due to: connection closed
01:59:52.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.056680 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13587
01:59:52.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.074206 13721 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.232404 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13587
01:59:52.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.259083 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13734
01:59:52.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.266784 13858 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:52.296629 13888 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.0.193:36941: connect: Connection refused (error 111)
01:59:52.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:52.298429 13888 consensus_peers.cc:597] T 70cc35cd5fa9453abe75ab6c60440dc8 P 71f4805d8c3d44e3b8d856d26d77bdcd -> Peer 917a64c734d447c9955619b8a8b128e7 (127.13.0.193:36941): Couldn't send request to peer 917a64c734d447c9955619b8a8b128e7. Status: Network error: Client connection negotiation failed: client connection to 127.13.0.193:36941: connect: Connection refused (error 111). This is attempt 1: this message will repeat every 5th retry.
01:59:52.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.362639 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13734
01:59:52.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.381455 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13870
01:59:52.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.389274 13992 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.504091 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13870
01:59:52.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.525619 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13327
01:59:52.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.527047 13388 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.640210 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13327
01:59:52.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.660115 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13395
01:59:52.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.661329 13459 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:52.686353 13484 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.0.254:45455: connect: Connection refused (error 111)
01:59:52.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 01:59:52.687702 13484 consensus_peers.cc:597] T 00000000000000000000000000000000 P e7029c7f7c3140d094fe0aecd3d8095f -> Peer 1e97bdc00699454292b1a31a5bcc5da3 (127.13.0.254:45455): Couldn't send request to peer 1e97bdc00699454292b1a31a5bcc5da3. Status: Network error: Client connection negotiation failed: client connection to 127.13.0.254:45455: connect: Connection refused (error 111). This is attempt 1: this message will repeat every 5th retry.
01:59:52.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.770977 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13395
01:59:52.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.793694 13315 external_mini_cluster.cc:1699] Attempting to check leaks for /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu pid 13466
01:59:52.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.794929 13530 generic_service.cc:196] Checking for leaks (request via RPC)
01:59:52.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 01:59:52.907999 13315 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskc2MSc3/build/asan/bin/kudu with pid 13466
01:59:52.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T01:59:52Z chronyd exiting

Time: 6.622

OK (1 test)

