JUnit version 4.13.2
.14:07:40.633 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779113260625
14:07:40.658 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:07:40.719 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:07:40.728 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskvmm9CY/test-tmp
14:07:40.733 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
14:07:40.736 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskvmm9CY/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
14:07:40.929 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

14:07:40.947 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:07:40.948 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:07:40.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:40.949815 16351 mini_oidc.cc:150] Starting JWKS server
14:07:40.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:40.950569 16351 webserver.cc:533] Webserver started at http://127.0.0.1:40617/ using document root <none> and password file <none>
14:07:40.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:40.950657 16351 mini_oidc.cc:186] Starting OIDC Discovery server
14:07:40.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:40.950845 16351 webserver.cc:533] Webserver started at http://127.0.0.1:46663/ using document root <none> and password file <none>
14:07:40.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:07:40Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:07:40.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:07:40Z Disabled control of system clock
14:07:40.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:40.962808 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:40.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:40.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal
14:07:40.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data
14:07:40.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:40.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:40.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:40.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:40.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:40.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:40.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/logs
14:07:40.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data/info.pb
14:07:40.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:40.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:40.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:40.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:40.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:40.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:40.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:40.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:40.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:07:40.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:40.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:40.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:40.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.254:36061
14:07:40.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.254
14:07:40.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:40.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:40.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:40.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:40.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:40.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:40.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:40.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:40.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json with env {}
14:07:41.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.040601 16363 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.040784 16363 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.040804 16363 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042498 16363 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:07:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042538 16363 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042551 16363 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:07:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042563 16363 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:07:41.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042575 16363 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:07:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.042586 16363 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40617/jwks.json
14:07:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.044363 16363 master_runner.cc:387] Master server non-default flags:
14:07:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data
14:07:41.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal
14:07:41.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:41.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:41.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.254:36061
14:07:41.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:41.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:41.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json
14:07:41.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data/info.pb
14:07:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.254
14:07:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16363
14:07:41.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/logs
14:07:41.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:07:41.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.044579 16363 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.044768 16363 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.047431 16369 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
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.047431 16368 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
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.047712 16371 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
14:07:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.048045 16363 server_base.cc:1061] running on GCE node
14:07:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.048276 16363 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.048544 16363 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.049698 16363 hybrid_clock.cc:648] HybridClock initialized: now 1779113261049674 us; error 37 us; skew 500 ppm
14:07:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.051316 16363 webserver.cc:533] Webserver started at http://127.15.247.254:33857/ using document root <none> and password file <none>
14:07:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.051518 16363 fs_manager.cc:362] Metadata directory not provided
14:07:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.051573 16363 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.051674 16363 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.052838 16363 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data/instance:
14:07:41.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f007667dec9d40928fe98a4360423d24"
14:07:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.053207 16363 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal/instance:
14:07:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f007667dec9d40928fe98a4360423d24"
14:07:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.056201 16363 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.000s	sys 0.003s
14:07:41.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.057031 16377 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.057226 16363 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:07:41.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.057293 16363 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal
14:07:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f007667dec9d40928fe98a4360423d24"
14:07:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.057351 16363 fs_report.cc:389] FS layout report
14:07:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal
14:07:41.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal
14:07:41.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data/data
14:07:41.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.069921 16363 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.070222 16363 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
14:07:41.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.070309 16363 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.074165 16363 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.254:36061
14:07:41.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.074252 16429 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.254:36061 every 8 connection(s)
14:07:41.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.074627 16363 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/data/info.pb
14:07:41.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.075465 16430 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:41.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.077258 16430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.077469 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16363
14:07:41.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.077587 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-0/wal/instance
14:07:41.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.078572 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal
14:07:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data
14:07:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/logs
14:07:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data/info.pb
14:07:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:41.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:07:41.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:41.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:41.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:41.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.253:36465
14:07:41.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.253
14:07:41.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:41.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:41.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json with env {}
14:07:41.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.085438 16430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.085897 16378 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.15.247.253:36465: connect: Connection refused (error 111)
14:07:41.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.086762 16430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.253:36465: Network error: Client connection negotiation failed: client connection to 127.15.247.253:36465: connect: Connection refused (error 111)
14:07:41.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.136050 16430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } attempt: 1
14:07:41.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.136871 16430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.253:36465: Network error: Client connection negotiation failed: client connection to 127.15.247.253:36465: connect: Connection refused (error 111)
14:07:41.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.165905 16434 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.166139 16434 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.166173 16434 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169009 16434 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:07:41.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169100 16434 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169126 16434 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:07:41.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169143 16434 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:07:41.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169160 16434 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:07:41.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.169194 16434 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40617/jwks.json
14:07:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.173134 16434 master_runner.cc:387] Master server non-default flags:
14:07:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:41.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.253:36465
14:07:41.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:41.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:41.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data/info.pb
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.253
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16434
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/logs
14:07:41.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:07:41.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.173478 16434 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.173732 16434 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.176514 16441 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
14:07:41.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.176512 16440 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
14:07:41.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.176507 16443 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
14:07:41.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.177350 16434 server_base.cc:1061] running on GCE node
14:07:41.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.177556 16434 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.177819 16434 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.178973 16434 hybrid_clock.cc:648] HybridClock initialized: now 1779113261178874 us; error 110 us; skew 500 ppm
14:07:41.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.180245 16434 webserver.cc:533] Webserver started at http://127.15.247.253:35813/ using document root <none> and password file <none>
14:07:41.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.180435 16434 fs_manager.cc:362] Metadata directory not provided
14:07:41.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.180487 16434 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.180584 16434 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.181650 16434 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data/instance:
14:07:41.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1e87a57277a48ce804b69e7663ce789"
14:07:41.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.181986 16434 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal/instance:
14:07:41.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1e87a57277a48ce804b69e7663ce789"
14:07:41.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.183460 16434 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:07:41.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.184176 16449 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.184305 16434 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.000s
14:07:41.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.184350 16434 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal
14:07:41.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1e87a57277a48ce804b69e7663ce789"
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.184401 16434 fs_report.cc:389] FS layout report
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal
14:07:41.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data/data
14:07:41.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.200395 16434 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.200714 16434 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
14:07:41.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.200836 16434 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.205036 16430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } attempt: 2
14:07:41.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.205699 16434 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.253:36465
14:07:41.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.205929 16501 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.253:36465 every 8 connection(s)
14:07:41.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.206465 16434 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/data/info.pb
14:07:41.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.207417 16503 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:41.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.207613 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16434
14:07:41.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.207685 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-1/wal/instance
14:07:41.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.209052 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/logs
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data/info.pb
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.252:40573
14:07:41.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.252
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:41.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:41.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json with env {}
14:07:41.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.212497 16430 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.213173 16430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.252:40573: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.216161 16503 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.221640 16503 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.226027 16503 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.226907 16452 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.227524 16503 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.252:40573: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.256335 16430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } attempt: 1
14:07:41.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.257249 16430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.252:40573: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.277060 16503 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } attempt: 1
14:07:41.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.278013 16503 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.252:40573: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.295614 16505 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.295882 16505 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.295909 16505 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297477 16505 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:07:41.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297523 16505 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297536 16505 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:07:41.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297549 16505 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:07:41.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297561 16505 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:07:41.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.297572 16505 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40617/jwks.json
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.299021 16505 master_runner.cc:387] Master server non-default flags:
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:07:41.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.252:40573
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:07:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40617/jwks.json
14:07:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data/info.pb
14:07:41.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.252
14:07:41.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16505
14:07:41.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/logs
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.299203 16505 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.299379 16505 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.303126 16512 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
14:07:41.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.303367 16513 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
14:07:41.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.304382 16430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } attempt: 2
14:07:41.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.304987 16430 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.15.247.252:40573: Network error: Client connection negotiation failed: client connection to 127.15.247.252:40573: connect: Connection refused (error 111)
14:07:41.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.308107 16505 server_base.cc:1061] running on GCE node
14:07:41.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.308111 16515 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
14:07:41.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.308748 16505 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.309048 16505 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.310220 16505 hybrid_clock.cc:648] HybridClock initialized: now 1779113261310198 us; error 32 us; skew 500 ppm
14:07:41.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.311556 16505 webserver.cc:533] Webserver started at http://127.15.247.252:42261/ using document root <none> and password file <none>
14:07:41.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.311793 16505 fs_manager.cc:362] Metadata directory not provided
14:07:41.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.311877 16505 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.311975 16505 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.313095 16505 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data/instance:
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b4f58047fab461aa32f638900e9d546"
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.313501 16505 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal/instance:
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b4f58047fab461aa32f638900e9d546"
14:07:41.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.315196 16505 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.001s
14:07:41.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.316205 16521 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.316430 16505 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:07:41.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.316490 16505 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal
14:07:41.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b4f58047fab461aa32f638900e9d546"
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.316540 16505 fs_report.cc:389] FS layout report
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data/data
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.331259 16505 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.331543 16505 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
14:07:41.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.331629 16505 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.335534 16505 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.252:40573
14:07:41.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.335608 16573 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.252:40573 every 8 connection(s)
14:07:41.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.335918 16505 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/data/info.pb
14:07:41.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.336423 16574 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:41.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.337190 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16505
14:07:41.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.337280 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/master-2/wal/instance
14:07:41.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.337637 16574 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.342772 16574 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.346187 16503 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } attempt: 2
14:07:41.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.346289 16574 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } has no permanent_uuid. Determining permanent_uuid...
14:07:41.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.352126 16503 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: Bootstrap starting.
14:07:41.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.352124 16574 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: Bootstrap starting.
14:07:41.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.352674 16503 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: Neither blocks nor log segments found. Creating new log.
14:07:41.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.352794 16574 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: Neither blocks nor log segments found. Creating new log.
14:07:41.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.352849 16503 log.cc:826] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: Log is configured to *not* fsync() on all Append() calls
14:07:41.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.353397 16574 log.cc:826] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: Log is configured to *not* fsync() on all Append() calls
14:07:41.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.353468 16503 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: No bootstrap required, opened a new log
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.354462 16574 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: No bootstrap required, opened a new log
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355110 16503 raft_consensus.cc:359] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355193 16503 raft_consensus.cc:385] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355211 16503 raft_consensus.cc:740] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c1e87a57277a48ce804b69e7663ce789, State: Initialized, Role: FOLLOWER
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355306 16503 consensus_queue.cc:260] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355518 16503 sys_catalog.cc:565] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: configured and running, proceeding with master startup.
14:07:41.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355542 16585 sys_catalog.cc:455] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355620 16585 sys_catalog.cc:458] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355758 16574 raft_consensus.cc:359] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355899 16574 raft_consensus.cc:385] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.355930 16574 raft_consensus.cc:740] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1b4f58047fab461aa32f638900e9d546, State: Initialized, Role: FOLLOWER
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.356030 16574 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.356284 16574 sys_catalog.cc:565] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: configured and running, proceeding with master startup.
14:07:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.357547 16434 master_runner.cc:187] Error getting master registration for 127.15.247.254:36061: OK, instance_id { permanent_uuid: "f007667dec9d40928fe98a4360423d24" instance_seqno: 1779113261073141 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:07:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.359136 16434 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:07:41.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.359658 16599 catalog_manager.cc:1593] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:07:41.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.359979 16599 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:07:41.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.360328 16589 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.361009 16589 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.359678 16505 master_runner.cc:187] Error getting master registration for 127.15.247.254:36061: OK, instance_id { permanent_uuid: "f007667dec9d40928fe98a4360423d24" instance_seqno: 1779113261073141 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:07:41.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.361476 16505 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:07:41.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.358660 16608 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:07:41.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.361532 16608 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:07:41.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.412147 16430 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } attempt: 3
14:07:41.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.416394 16430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: Bootstrap starting.
14:07:41.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.417109 16430 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: Neither blocks nor log segments found. Creating new log.
14:07:41.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.417677 16430 log.cc:826] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: Log is configured to *not* fsync() on all Append() calls
14:07:41.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.418577 16430 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: No bootstrap required, opened a new log
14:07:41.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.420188 16430 raft_consensus.cc:359] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.420310 16430 raft_consensus.cc:385] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:41.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.420341 16430 raft_consensus.cc:740] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f007667dec9d40928fe98a4360423d24, State: Initialized, Role: FOLLOWER
14:07:41.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.420426 16430 consensus_queue.cc:260] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.420691 16430 sys_catalog.cc:565] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: configured and running, proceeding with master startup.
14:07:41.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.422619 16623 catalog_manager.cc:1593] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:07:41.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.423066 16612 sys_catalog.cc:455] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.424680 16612 sys_catalog.cc:458] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.424582 16363 master_runner.cc:264] No leader master found from master f007667dec9d40928fe98a4360423d24
14:07:41.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.424746 16363 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:07:41.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.422925 16623 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:07:41.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.446419 16589 raft_consensus.cc:493] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:07:41.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.446533 16589 raft_consensus.cc:515] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.446754 16589 leader_election.cc:290] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers f007667dec9d40928fe98a4360423d24 (127.15.247.254:36061), c1e87a57277a48ce804b69e7663ce789 (127.15.247.253:36465)
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447096 16404 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1b4f58047fab461aa32f638900e9d546" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f007667dec9d40928fe98a4360423d24" is_pre_election: true
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447216 16404 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1b4f58047fab461aa32f638900e9d546 in term 0.
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447407 16524 leader_election.cc:304] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [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: 1b4f58047fab461aa32f638900e9d546, f007667dec9d40928fe98a4360423d24; no voters: 
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447623 16476 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1b4f58047fab461aa32f638900e9d546" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c1e87a57277a48ce804b69e7663ce789" is_pre_election: true
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447736 16476 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1b4f58047fab461aa32f638900e9d546 in term 0.
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.447996 16589 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:07:41.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.448046 16589 raft_consensus.cc:493] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:07:41.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.448069 16589 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 0 FOLLOWER]: Advancing to term 1
14:07:41.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.448899 16589 raft_consensus.cc:515] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.451303 16589 leader_election.cc:290] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [CANDIDATE]: Term 1 election: Requested vote from peers f007667dec9d40928fe98a4360423d24 (127.15.247.254:36061), c1e87a57277a48ce804b69e7663ce789 (127.15.247.253:36465)
14:07:41.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.451462 16455 tablet.cc:2404] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:07:41.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.451634 16404 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1b4f58047fab461aa32f638900e9d546" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f007667dec9d40928fe98a4360423d24"
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.451717 16404 raft_consensus.cc:3060] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 0 FOLLOWER]: Advancing to term 1
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.452630 16404 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1b4f58047fab461aa32f638900e9d546 in term 1.
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.452826 16524 leader_election.cc:304] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [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: 1b4f58047fab461aa32f638900e9d546, f007667dec9d40928fe98a4360423d24; no voters: 
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.453014 16476 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "1b4f58047fab461aa32f638900e9d546" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c1e87a57277a48ce804b69e7663ce789"
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.453099 16476 raft_consensus.cc:3060] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 0 FOLLOWER]: Advancing to term 1
14:07:41.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.453967 16476 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1b4f58047fab461aa32f638900e9d546 in term 1.
14:07:41.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.454195 16589 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 1 FOLLOWER]: Leader election won for term 1
14:07:41.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.454356 16589 raft_consensus.cc:697] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [term 1 LEADER]: Becoming Leader. State: Replica: 1b4f58047fab461aa32f638900e9d546, State: Running, Role: LEADER
14:07:41.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.454459 16589 consensus_queue.cc:237] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [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: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } }
14:07:41.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.454871 16589 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1b4f58047fab461aa32f638900e9d546. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.454946 16589 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: This master's current role is: LEADER
14:07:41.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.458251 16627 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
14:07:41.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.458742 16627 catalog_manager.cc:1519] Initializing Kudu cluster ID...
14:07:41.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.463477 16476 raft_consensus.cc:1275] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [term 1 FOLLOWER]: Refusing update from remote peer 1b4f58047fab461aa32f638900e9d546: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:07:41.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.463724 16404 raft_consensus.cc:1275] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [term 1 FOLLOWER]: Refusing update from remote peer 1b4f58047fab461aa32f638900e9d546: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:07:41.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.464561 16589 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [LEADER]: Connected to new peer: Peer: permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:07:41.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.464965 16589 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:07:41.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.466094 16612 sys_catalog.cc:455] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1b4f58047fab461aa32f638900e9d546. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.466173 16612 sys_catalog.cc:458] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.467011 16585 sys_catalog.cc:455] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 1b4f58047fab461aa32f638900e9d546. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.467100 16585 sys_catalog.cc:458] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.470398 16589 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.470499 16589 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: This master's current role is: LEADER
14:07:41.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.471544 16585 sys_catalog.cc:455] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.471632 16585 sys_catalog.cc:458] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.472527 16628 mvcc.cc:204] Tried to move back new op lower bound from 7287247918951452672 to 7287247918918266880. Current Snapshot: MvccSnapshot[applied={T|T < 7287247918951452672}]
14:07:41.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.474531 16589 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.474617 16589 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546 [sys.catalog]: This master's current role is: LEADER
14:07:41.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.475628 16612 sys_catalog.cc:455] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "1b4f58047fab461aa32f638900e9d546" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f007667dec9d40928fe98a4360423d24" member_type: VOTER last_known_addr { host: "127.15.247.254" port: 36061 } } peers { permanent_uuid: "c1e87a57277a48ce804b69e7663ce789" member_type: VOTER last_known_addr { host: "127.15.247.253" port: 36465 } } peers { permanent_uuid: "1b4f58047fab461aa32f638900e9d546" member_type: VOTER last_known_addr { host: "127.15.247.252" port: 40573 } } }
14:07:41.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.475729 16612 sys_catalog.cc:458] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24 [sys.catalog]: This master's current role is: FOLLOWER
14:07:41.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.476547 16631 mvcc.cc:204] Tried to move back new op lower bound from 7287247918951452672 to 7287247918918266880. Current Snapshot: MvccSnapshot[applied={T|T < 7287247918951452672}]
14:07:41.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.476902 16629 mvcc.cc:204] Tried to move back new op lower bound from 7287247918951452672 to 7287247918918266880. Current Snapshot: MvccSnapshot[applied={T|T < 7287247918951452672}]
14:07:41.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.480836 16627 catalog_manager.cc:1382] Generated new cluster ID: 987aa9f4de9f4f17aa8583336b51b943
14:07:41.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.480898 16627 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
14:07:41.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.498857 16627 catalog_manager.cc:1405] Generated new certificate authority record
14:07:41.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.500016 16627 catalog_manager.cc:1539] Loading token signing keys...
14:07:41.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.508229 16627 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 1b4f58047fab461aa32f638900e9d546: Generated new TSK 0
14:07:41.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.508780 16627 catalog_manager.cc:1549] Initializing in-progress tserver states...
14:07:41.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.513440 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/logs
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data/info.pb
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.193:0
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.193
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.193
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:07:41.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.634567 16637 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.634766 16637 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.634799 16637 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.636555 16637 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.636653 16637 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.247.193
14:07:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.638429 16637 tablet_server_runner.cc:78] Tablet server non-default flags:
14:07:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.193:0
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data/info.pb
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.193
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16637
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.193
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/logs
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:07:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.638688 16637 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.639014 16637 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.643787 16642 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
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.643886 16643 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
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.643947 16645 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
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.644224 16637 server_base.cc:1061] running on GCE node
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.644375 16637 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.644598 16637 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.645761 16637 hybrid_clock.cc:648] HybridClock initialized: now 1779113261645745 us; error 32 us; skew 500 ppm
14:07:41.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.647344 16637 webserver.cc:533] Webserver started at http://127.15.247.193:39321/ using document root <none> and password file <none>
14:07:41.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.647564 16637 fs_manager.cc:362] Metadata directory not provided
14:07:41.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.647611 16637 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.647706 16637 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.648746 16637 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data/instance:
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1064ca681e5b49a4afa7678b0144bb61"
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.649102 16637 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal/instance:
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1064ca681e5b49a4afa7678b0144bb61"
14:07:41.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.650844 16637 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.002s
14:07:41.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.651759 16651 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.651944 16637 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.652004 16637 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1064ca681e5b49a4afa7678b0144bb61"
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.652065 16637 fs_report.cc:389] FS layout report
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data/data
14:07:41.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.675644 16637 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676065 16637 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
14:07:41.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676187 16637 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676391 16637 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:07:41.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676707 16637 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:07:41.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676738 16637 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:07:41.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676762 16637 ts_tablet_manager.cc:616] Registered 0 tablets
14:07:41.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.676777 16637 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:07:41.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.683836 16637 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.193:45525
14:07:41.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.683951 16764 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.193:45525 every 8 connection(s)
14:07:41.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.684374 16637 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/data/info.pb
14:07:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.688031 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16637
14:07:41.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.688135 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-0/wal/instance
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.690596 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/logs
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data/info.pb
14:07:41.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.194:0
14:07:41.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.194
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.194
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.690665 16766 heartbeater.cc:344] Connected to a master server at 127.15.247.254:36061
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.690671 16767 heartbeater.cc:344] Connected to a master server at 127.15.247.253:36465
14:07:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.690774 16767 heartbeater.cc:461] Registering TS with master...
14:07:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.690775 16766 heartbeater.cc:461] Registering TS with master...
14:07:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.691005 16767 heartbeater.cc:507] Master 127.15.247.253:36465 requested a full tablet report, sending...
14:07:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.691133 16766 heartbeater.cc:507] Master 127.15.247.254:36061 requested a full tablet report, sending...
14:07:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.691488 16393 ts_manager.cc:194] Registered new tserver with Master: 1064ca681e5b49a4afa7678b0144bb61 (127.15.247.193:45525)
14:07:41.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.691757 16466 ts_manager.cc:194] Registered new tserver with Master: 1064ca681e5b49a4afa7678b0144bb61 (127.15.247.193:45525)
14:07:41.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.696040 16765 heartbeater.cc:344] Connected to a master server at 127.15.247.252:40573
14:07:41.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.696120 16765 heartbeater.cc:461] Registering TS with master...
14:07:41.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.696214 16765 heartbeater.cc:507] Master 127.15.247.252:40573 requested a full tablet report, sending...
14:07:41.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.696655 16538 ts_manager.cc:194] Registered new tserver with Master: 1064ca681e5b49a4afa7678b0144bb61 (127.15.247.193:45525)
14:07:41.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.697314 16538 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.247.193:38131
14:07:41.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.778445 16772 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.778649 16772 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.778680 16772 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.780496 16772 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.780591 16772 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.247.194
14:07:41.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.782336 16772 tablet_server_runner.cc:78] Tablet server non-default flags:
14:07:41.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.194:0
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data/info.pb
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.194
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16772
14:07:41.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.194
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/logs
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.782634 16772 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.782927 16772 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.786231 16777 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
14:07:41.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.786242 16778 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
14:07:41.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.786458 16780 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
14:07:41.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.786908 16772 server_base.cc:1061] running on GCE node
14:07:41.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.787098 16772 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.787298 16772 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.788537 16772 hybrid_clock.cc:648] HybridClock initialized: now 1779113261788495 us; error 42 us; skew 500 ppm
14:07:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.789835 16772 webserver.cc:533] Webserver started at http://127.15.247.194:42279/ using document root <none> and password file <none>
14:07:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.790053 16772 fs_manager.cc:362] Metadata directory not provided
14:07:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.790100 16772 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.790304 16772 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.791337 16772 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data/instance:
14:07:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f85002733a7d46e8b96cde8e1f9cd094"
14:07:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.791993 16772 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal/instance:
14:07:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f85002733a7d46e8b96cde8e1f9cd094"
14:07:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.793563 16772 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
14:07:41.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.794611 16786 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.794888 16772 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:07:41.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.795044 16772 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal
14:07:41.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f85002733a7d46e8b96cde8e1f9cd094"
14:07:41.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.795147 16772 fs_report.cc:389] FS layout report
14:07:41.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data/data
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.826740 16772 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.827093 16772 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
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.827462 16772 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.827947 16772 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.828568 16772 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.828650 16772 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.828686 16772 ts_tablet_manager.cc:616] Registered 0 tablets
14:07:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.828704 16772 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:07:41.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.835130 16772 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.194:38391
14:07:41.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.835237 16899 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.194:38391 every 8 connection(s)
14:07:41.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.835558 16772 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/data/info.pb
14:07:41.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.836836 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16772
14:07:41.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.836936 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-1/wal/instance
14:07:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.838289 16351 external_mini_cluster.cc:1366] Running /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskvmm9CY/build/release/bin/kudu
14:07:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal
14:07:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/logs
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data/info.pb
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.195:0
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.195
14:07:41.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.195
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:07:41.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.842231 16902 heartbeater.cc:344] Connected to a master server at 127.15.247.253:36465
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.842344 16902 heartbeater.cc:461] Registering TS with master...
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.842545 16902 heartbeater.cc:507] Master 127.15.247.253:36465 requested a full tablet report, sending...
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.843032 16466 ts_manager.cc:194] Registered new tserver with Master: f85002733a7d46e8b96cde8e1f9cd094 (127.15.247.194:38391)
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.843206 16901 heartbeater.cc:344] Connected to a master server at 127.15.247.254:36061
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.843268 16901 heartbeater.cc:461] Registering TS with master...
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.843365 16901 heartbeater.cc:507] Master 127.15.247.254:36061 requested a full tablet report, sending...
14:07:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.843626 16393 ts_manager.cc:194] Registered new tserver with Master: f85002733a7d46e8b96cde8e1f9cd094 (127.15.247.194:38391)
14:07:41.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.844521 16900 heartbeater.cc:344] Connected to a master server at 127.15.247.252:40573
14:07:41.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.844592 16900 heartbeater.cc:461] Registering TS with master...
14:07:41.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.844686 16900 heartbeater.cc:507] Master 127.15.247.252:40573 requested a full tablet report, sending...
14:07:41.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.845021 16538 ts_manager.cc:194] Registered new tserver with Master: f85002733a7d46e8b96cde8e1f9cd094 (127.15.247.194:38391)
14:07:41.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.845553 16538 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.247.194:56845
14:07:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.927276 16907 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:07:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.927465 16907 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:07:41.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.927486 16907 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:07:41.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.929253 16907 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:07:41.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.929315 16907 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.15.247.195
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.930958 16907 tablet_server_runner.cc:78] Tablet server non-default flags:
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.15.247.212:33043
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.15.247.195:0
14:07:41.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data/info.pb
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.15.247.195
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.15.247.254:36061,127.15.247.253:36465,127.15.247.252:40573
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.16907
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.15.247.195
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/logs
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 13:43:14 UTC on e7f111948823
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11957
14:07:41.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.931172 16907 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:07:41.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.931368 16907 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.933911 16913 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
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.933929 16912 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
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.934120 16907 server_base.cc:1061] running on GCE node
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:41.933929 16915 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
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.934485 16907 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:07:41.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.934722 16907 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:07:41.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.935902 16907 hybrid_clock.cc:648] HybridClock initialized: now 1779113261935854 us; error 33 us; skew 500 ppm
14:07:41.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.936973 16907 webserver.cc:533] Webserver started at http://127.15.247.195:33405/ using document root <none> and password file <none>
14:07:41.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.937209 16907 fs_manager.cc:362] Metadata directory not provided
14:07:41.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.937291 16907 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:07:41.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.937402 16907 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:07:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.938320 16907 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data/instance:
14:07:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff8ec434cf6240ddb7b8ee70636a9a84"
14:07:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.938839 16907 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal/instance:
14:07:41.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff8ec434cf6240ddb7b8ee70636a9a84"
14:07:41.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.940358 16907 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
14:07:41.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.941226 16921 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:07:41.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.941541 16907 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:07:41.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.941610 16907 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data,/tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ff8ec434cf6240ddb7b8ee70636a9a84"
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:07:41 on dist-test-slave-5czt"
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.941671 16907 fs_report.cc:389] FS layout report
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data/data
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:07:41.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:07:41.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:07:41.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:07:41.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:07:41.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:07:41.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.952781 16907 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:07:41.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953106 16907 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
14:07:41.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953233 16907 kserver.cc:163] Server-wide thread pool size limit: 3276
14:07:41.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953495 16907 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:07:41.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953879 16907 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:07:41.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953936 16907 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:07:41.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953969 16907 ts_tablet_manager.cc:616] Registered 0 tablets
14:07:41.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.953986 16907 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:07:41.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.960984 16907 rpc_server.cc:307] RPC server started. Bound to: 127.15.247.195:33181
14:07:41.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.961098 17034 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.15.247.195:33181 every 8 connection(s)
14:07:41.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.961344 16907 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/data/info.pb
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.966456 16351 external_mini_cluster.cc:1428] Started /tmp/dist-test-taskvmm9CY/build/release/bin/kudu as pid 16907
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.966547 16351 external_mini_cluster.cc:1442] Reading /tmp/dist-test-taskvmm9CY/test-tmp/mini-kudu-cluster10495867571633396802/ts-2/wal/instance
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967029 17037 heartbeater.cc:344] Connected to a master server at 127.15.247.253:36465
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967128 17037 heartbeater.cc:461] Registering TS with master...
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967330 17037 heartbeater.cc:507] Master 127.15.247.253:36465 requested a full tablet report, sending...
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967427 17036 heartbeater.cc:344] Connected to a master server at 127.15.247.254:36061
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967463 17036 heartbeater.cc:461] Registering TS with master...
14:07:41.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967545 17036 heartbeater.cc:507] Master 127.15.247.254:36061 requested a full tablet report, sending...
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967674 17035 heartbeater.cc:344] Connected to a master server at 127.15.247.252:40573
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967715 17035 heartbeater.cc:461] Registering TS with master...
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967737 16466 ts_manager.cc:194] Registered new tserver with Master: ff8ec434cf6240ddb7b8ee70636a9a84 (127.15.247.195:33181)
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967789 17035 heartbeater.cc:507] Master 127.15.247.252:40573 requested a full tablet report, sending...
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.967903 16393 ts_manager.cc:194] Registered new tserver with Master: ff8ec434cf6240ddb7b8ee70636a9a84 (127.15.247.195:33181)
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.968029 16537 ts_manager.cc:194] Registered new tserver with Master: ff8ec434cf6240ddb7b8ee70636a9a84 (127.15.247.195:33181)
14:07:41.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.968566 16537 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.15.247.195:58069
14:07:41.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:41.970742 16351 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:07:41.971 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:07:41.972 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:07:41.980 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.15.247.254"
      port: 36061
    }
    bound_http_address {
      host: "127.15.247.254"
      port: 33857
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.15.247.253"
      port: 36465
    }
    bound_http_address {
      host: "127.15.247.253"
      port: 35813
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.15.247.252"
      port: 40573
    }
    bound_http_address {
      host: "127.15.247.252"
      port: 42261
    }
  }
}

14:07:41.983 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

14:07:41.985 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.15.247.193"
      port: 45525
    }
    bound_http_address {
      host: "127.15.247.193"
      port: 39321
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.15.247.194"
      port: 38391
    }
    bound_http_address {
      host: "127.15.247.194"
      port: 42279
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.15.247.195"
      port: 33181
    }
    bound_http_address {
      host: "127.15.247.195"
      port: 33405
    }
  }
}

14:07:41.985 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:07:42.156 [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)
14:07:42.201 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:07:42.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.360672 16599 catalog_manager.cc:1294] Loaded cluster ID: 987aa9f4de9f4f17aa8583336b51b943
14:07:42.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.360744 16599 catalog_manager.cc:1587] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: loading cluster ID for follower catalog manager: success
14:07:42.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.361990 16599 catalog_manager.cc:1609] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: acquiring CA information for follower catalog manager: success
14:07:42.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.362277 16599 catalog_manager.cc:1637] T 00000000000000000000000000000000 P c1e87a57277a48ce804b69e7663ce789: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:07:42.384 [DEBUG - main] (Connection.java:748) [peer master-127.15.247.253:36465(127.15.247.253:36465)] connecting to peer
14:07:42.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.425969 16623 catalog_manager.cc:1294] Loaded cluster ID: 987aa9f4de9f4f17aa8583336b51b943
14:07:42.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.426043 16623 catalog_manager.cc:1587] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: loading cluster ID for follower catalog manager: success
14:07:42.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.427294 16623 catalog_manager.cc:1609] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: acquiring CA information for follower catalog manager: success
14:07:42.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.427598 16623 catalog_manager.cc:1637] T 00000000000000000000000000000000 P f007667dec9d40928fe98a4360423d24: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:07:42.443 [DEBUG - main] (Connection.java:748) [peer master-127.15.247.254:36061(127.15.247.254:36061)] connecting to peer
14:07:42.453 [DEBUG - main] (Connection.java:748) [peer master-127.15.247.252:40573(127.15.247.252:40573)] connecting to peer
14:07:42.464 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.15.247.253:36465(127.15.247.253:36465)] Successfully connected to peer
14:07:42.465 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.15.247.254:36061(127.15.247.254:36061)] Successfully connected to peer
14:07:42.466 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.15.247.252:40573(127.15.247.252:40573)] Successfully connected to peer
14:07:42.587 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.247.253
14:07:42.587 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.247.252
14:07:42.591 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.15.247.254
14:07:42.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.698026 16765 heartbeater.cc:499] Master 127.15.247.252:40573 was elected leader, sending a full tablet report...
14:07:42.836 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x5a211829, L:/127.0.0.1:53594 - R:/127.15.247.252:40573] using SASL/PLAIN
14:07:42.836 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x8f0d754c, L:/127.0.0.1:53620 - R:/127.15.247.254:36061] using SASL/PLAIN
14:07:42.837 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xd12d97ac, L:/127.0.0.1:37644 - R:/127.15.247.253:36465] using SASL/PLAIN
14:07:42.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.846275 16900 heartbeater.cc:499] Master 127.15.247.252:40573 was elected leader, sending a full tablet report...
14:07:42.875 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:07:42.876 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=542), Traces: [0ms] refreshing cache from master, [31ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.247.253:36465, [105ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.247.254:36061, [115ms] Sub RPC ConnectToMaster: sending RPC to server master-127.15.247.252:40573, [512ms] Sub RPC ConnectToMaster: received response from server master-127.15.247.254:36061: OK, [512ms] Sub RPC ConnectToMaster: received response from server master-127.15.247.253:36465: OK, [513ms] Sub RPC ConnectToMaster: received response from server master-127.15.247.252:40573: OK, deferred=null) after lookup
14:07:42.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.932886 16537 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:53594:
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1779113260530"
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:07:42.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:42.933288 16537 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-1779113260530 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
14:07:42.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.952454 16834 tablet_service.cc:1511] Processing CreateTablet for tablet 2e1c32b5937a4492b9508f6556788497 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779113260530 [id=b2014b9d12144c669a266dd651525973]), partition=RANGE (key) PARTITION UNBOUNDED
14:07:42.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.952540 16969 tablet_service.cc:1511] Processing CreateTablet for tablet 2e1c32b5937a4492b9508f6556788497 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779113260530 [id=b2014b9d12144c669a266dd651525973]), partition=RANGE (key) PARTITION UNBOUNDED
14:07:42.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.952811 16834 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 2e1c32b5937a4492b9508f6556788497. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:42.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.952834 16969 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 2e1c32b5937a4492b9508f6556788497. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:42.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.953415 16699 tablet_service.cc:1511] Processing CreateTablet for tablet 2e1c32b5937a4492b9508f6556788497 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779113260530 [id=b2014b9d12144c669a266dd651525973]), partition=RANGE (key) PARTITION UNBOUNDED
14:07:42.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.953645 16699 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 2e1c32b5937a4492b9508f6556788497. 1 dirs total, 0 dirs full, 0 dirs failed
14:07:42.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.958104 17064 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: Bootstrap starting.
14:07:42.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.959471 17064 tablet_bootstrap.cc:654] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: Neither blocks nor log segments found. Creating new log.
14:07:42.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.960628 17064 log.cc:826] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: Log is configured to *not* fsync() on all Append() calls
14:07:42.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.961319 17065 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Bootstrap starting.
14:07:42.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.962639 17065 tablet_bootstrap.cc:654] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Neither blocks nor log segments found. Creating new log.
14:07:42.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.963021 17065 log.cc:826] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Log is configured to *not* fsync() on all Append() calls
14:07:42.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.963057 17064 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: No bootstrap required, opened a new log
14:07:42.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.963179 17064 ts_tablet_manager.cc:1403] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: Time spent bootstrapping tablet: real 0.005s	user 0.002s	sys 0.000s
14:07:42.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.963438 17066 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: Bootstrap starting.
14:07:42.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.964150 17066 tablet_bootstrap.cc:654] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: Neither blocks nor log segments found. Creating new log.
14:07:42.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.964457 17066 log.cc:826] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: Log is configured to *not* fsync() on all Append() calls
14:07:42.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.964823 17064 raft_consensus.cc:359] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965170 17065 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: No bootstrap required, opened a new log
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965205 17064 raft_consensus.cc:385] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965224 17066 tablet_bootstrap.cc:492] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: No bootstrap required, opened a new log
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965246 17064 raft_consensus.cc:740] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ff8ec434cf6240ddb7b8ee70636a9a84, State: Initialized, Role: FOLLOWER
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965250 17065 ts_tablet_manager.cc:1403] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Time spent bootstrapping tablet: real 0.004s	user 0.002s	sys 0.000s
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965283 17066 ts_tablet_manager.cc:1403] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965386 17064 consensus_queue.cc:260] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [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: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965610 17064 ts_tablet_manager.cc:1434] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.965718 17035 heartbeater.cc:499] Master 127.15.247.252:40573 was elected leader, sending a full tablet report...
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.966974 17066 raft_consensus.cc:359] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967128 17066 raft_consensus.cc:385] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967159 17066 raft_consensus.cc:740] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1064ca681e5b49a4afa7678b0144bb61, State: Initialized, Role: FOLLOWER
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967067 17065 raft_consensus.cc:359] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967193 17065 raft_consensus.cc:385] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967223 17065 raft_consensus.cc:740] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f85002733a7d46e8b96cde8e1f9cd094, State: Initialized, Role: FOLLOWER
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967245 17066 consensus_queue.cc:260] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [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: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967307 17065 consensus_queue.cc:260] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [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: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967468 17066 ts_tablet_manager.cc:1434] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
14:07:42.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:42.967518 17065 ts_tablet_manager.cc:1434] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
14:07:42.971 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table b2014b9d12144c669a266dd651525973
14:07:43.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.003674 17070 raft_consensus.cc:493] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:07:43.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.003868 17070 raft_consensus.cc:515] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:43.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.004210 17070 leader_election.cc:290] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 1064ca681e5b49a4afa7678b0144bb61 (127.15.247.193:45525), f85002733a7d46e8b96cde8e1f9cd094 (127.15.247.194:38391)
14:07:43.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009159 16854 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "2e1c32b5937a4492b9508f6556788497" candidate_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f85002733a7d46e8b96cde8e1f9cd094" is_pre_election: true
14:07:43.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009217 16719 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "2e1c32b5937a4492b9508f6556788497" candidate_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1064ca681e5b49a4afa7678b0144bb61" is_pre_election: true
14:07:43.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009316 16854 raft_consensus.cc:2468] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ff8ec434cf6240ddb7b8ee70636a9a84 in term 0.
14:07:43.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009382 16719 raft_consensus.cc:2468] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ff8ec434cf6240ddb7b8ee70636a9a84 in term 0.
14:07:43.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009572 16922 leader_election.cc:304] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [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: f85002733a7d46e8b96cde8e1f9cd094, ff8ec434cf6240ddb7b8ee70636a9a84; no voters: 
14:07:43.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009780 17070 raft_consensus.cc:2804] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:07:43.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009867 17070 raft_consensus.cc:493] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:07:43.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.009900 17070 raft_consensus.cc:3060] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 0 FOLLOWER]: Advancing to term 1
14:07:43.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.010787 17070 raft_consensus.cc:515] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:43.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.011179 16719 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "2e1c32b5937a4492b9508f6556788497" candidate_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1064ca681e5b49a4afa7678b0144bb61"
14:07:43.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.011297 16719 raft_consensus.cc:3060] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 0 FOLLOWER]: Advancing to term 1
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.011356 16854 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "2e1c32b5937a4492b9508f6556788497" candidate_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f85002733a7d46e8b96cde8e1f9cd094"
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.011445 16854 raft_consensus.cc:3060] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 0 FOLLOWER]: Advancing to term 1
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.012310 16719 raft_consensus.cc:2468] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ff8ec434cf6240ddb7b8ee70636a9a84 in term 1.
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.012387 16854 raft_consensus.cc:2468] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ff8ec434cf6240ddb7b8ee70636a9a84 in term 1.
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.012605 16925 leader_election.cc:304] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [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: 1064ca681e5b49a4afa7678b0144bb61, ff8ec434cf6240ddb7b8ee70636a9a84; no voters: 
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.012830 17070 leader_election.cc:290] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [CANDIDATE]: Term 1 election: Requested vote from peers 1064ca681e5b49a4afa7678b0144bb61 (127.15.247.193:45525), f85002733a7d46e8b96cde8e1f9cd094 (127.15.247.194:38391)
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.012856 17075 raft_consensus.cc:2804] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 1 FOLLOWER]: Leader election won for term 1
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.013106 17075 raft_consensus.cc:697] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [term 1 LEADER]: Becoming Leader. State: Replica: ff8ec434cf6240ddb7b8ee70636a9a84, State: Running, Role: LEADER
14:07:43.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.013222 17075 consensus_queue.cc:237] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [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: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } }
14:07:43.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.014166 16538 catalog_manager.cc:5696] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 reported cstate change: term changed from 0 to 1, leader changed from <none> to ff8ec434cf6240ddb7b8ee70636a9a84 (127.15.247.195). New cstate: current_term: 1 leader_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "ff8ec434cf6240ddb7b8ee70636a9a84" member_type: VOTER last_known_addr { host: "127.15.247.195" port: 33181 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 } health_report { overall_health: UNKNOWN } } }
14:07:43.050 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 2e1c32b5937a4492b9508f6556788497 for table 'org.apache.kudu.client.TestHybridTime-1779113260530' with partition [<start>, <end>)
14:07:43.056 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=2e1c32b5937a4492b9508f6556788497@[1064ca681e5b49a4afa7678b0144bb61(127.15.247.193:45525),f85002733a7d46e8b96cde8e1f9cd094(127.15.247.194:38391),ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)[L]]}]
14:07:43.058 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=18), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.15.247.252:40573, [8ms] Sub RPC GetTableLocations: received response from server master-127.15.247.252:40573: OK, deferred=null) after lookup
14:07:43.067 [DEBUG - kudu-nio-2] (Connection.java:748) [peer ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)] connecting to peer
14:07:43.070 [DEBUG - kudu-nio-3] (Connection.java:757) [peer ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)] Successfully connected to peer
14:07:43.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:07:43.087530 16903 tablet.cc:2404] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:07:43.152 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xbbb5f854, L:/127.0.0.1:41570 - R:/127.15.247.195:33181] using TOKEN/null
14:07:43.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.155530 16719 raft_consensus.cc:1275] T 2e1c32b5937a4492b9508f6556788497 P 1064ca681e5b49a4afa7678b0144bb61 [term 1 FOLLOWER]: Refusing update from remote peer ff8ec434cf6240ddb7b8ee70636a9a84: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:07:43.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.155530 16854 raft_consensus.cc:1275] T 2e1c32b5937a4492b9508f6556788497 P f85002733a7d46e8b96cde8e1f9cd094 [term 1 FOLLOWER]: Refusing update from remote peer ff8ec434cf6240ddb7b8ee70636a9a84: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:07:43.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.155906 17075 consensus_queue.cc:1048] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f85002733a7d46e8b96cde8e1f9cd094" member_type: VOTER last_known_addr { host: "127.15.247.194" port: 38391 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:07:43.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.156240 17075 consensus_queue.cc:1048] T 2e1c32b5937a4492b9508f6556788497 P ff8ec434cf6240ddb7b8ee70636a9a84 [LEADER]: Connected to new peer: Peer: permanent_uuid: "1064ca681e5b49a4afa7678b0144bb61" member_type: VOTER last_known_addr { host: "127.15.247.193" port: 45525 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:07:43.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.159758 17080 mvcc.cc:204] Tried to move back new op lower bound from 7287247925882195968 to 7287247925302960128. Current Snapshot: MvccSnapshot[applied={T|T < 7287247925882195968}]
14:07:43.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.162107 17083 mvcc.cc:204] Tried to move back new op lower bound from 7287247925882195968 to 7287247925302960128. Current Snapshot: MvccSnapshot[applied={T|T < 7287247925882195968}]
14:07:43.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.162861 17081 mvcc.cc:204] Tried to move back new op lower bound from 7287247925882195968 to 7287247925302960128. Current Snapshot: MvccSnapshot[applied={T|T < 7287247925882195968}]
14:07:43.196 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.206 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.213 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.218 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@249081633(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:07:43.227 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.228 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@301710259(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:07:43.235 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.235 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1765971515(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:07:43.240 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
14:07:43.286 [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-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.291 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7287247946362195969) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.295 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7287247946362195973) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.298 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7287247946362195977) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.303 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7287247946362195983) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.306 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7287247946362195987) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.310 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7287247946362195991) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.314 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7287247946362195992) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779113260530, tablet=2e1c32b5937a4492b9508f6556788497, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:07:43.318 [DEBUG - main] (Connection.java:575) [peer ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)] disconnecting while in state READY
14:07:43.319 [DEBUG - main] (Connection.java:575) [peer master-127.15.247.252:40573(127.15.247.252:40573)] disconnecting while in state READY
14:07:43.321 [DEBUG - main] (Connection.java:575) [peer master-127.15.247.254:36061(127.15.247.254:36061)] disconnecting while in state READY
14:07:43.325 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.15.247.252:40573(127.15.247.252:40573)] handling channelInactive
14:07:43.325 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.15.247.252:40573(127.15.247.252:40573)] cleaning up while in state READY due to: connection closed
14:07:43.326 [DEBUG - main] (Connection.java:575) [peer master-127.15.247.253:36465(127.15.247.253:36465)] disconnecting while in state READY
14:07:43.326 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.15.247.254:36061(127.15.247.254:36061)] handling channelInactive
14:07:43.327 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.15.247.254:36061(127.15.247.254:36061)] cleaning up while in state READY due to: connection closed
14:07:43.327 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.15.247.253:36465(127.15.247.253:36465)] handling channelInactive
14:07:43.328 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.15.247.253:36465(127.15.247.253:36465)] cleaning up while in state READY due to: connection closed
14:07:43.329 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:07:43.339 [DEBUG - kudu-nio-3] (Connection.java:239) [peer ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)] handling channelInactive
14:07:43.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.339394 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16637
14:07:43.340 [DEBUG - kudu-nio-3] (Connection.java:709) [peer ff8ec434cf6240ddb7b8ee70636a9a84(127.15.247.195:33181)] cleaning up while in state READY due to: connection closed
14:07:43.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.346652 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16772
14:07:43.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.354213 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16907
14:07:43.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.360020 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16363
14:07:43.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.365522 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16434
14:07:43.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:07:43.371348 16351 external_mini_cluster.cc:1658] Killing /tmp/dist-test-taskvmm9CY/build/release/bin/kudu with pid 16505
14:07:43.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:07:43Z chronyd exiting

Time: 3.054

OK (1 test)

