JUnit version 4.13.2
.08:03:25.185 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779091405175
08:03:25.214 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
08:03:25.275 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
08:03:25.283 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-tasksvLHYa/test-tmp
08:03:25.288 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
08:03:25.291 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-tasksvLHYa/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
08:03:25.497 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

08:03:25.511 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:03:25.512 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

08:03:25.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.513514  5062 mini_oidc.cc:150] Starting JWKS server
08:03:25.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.515626  5062 webserver.cc:533] Webserver started at http://127.0.0.1:40921/ using document root <none> and password file <none>
08:03:25.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.515820  5062 mini_oidc.cc:186] Starting OIDC Discovery server
08:03:25.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.516196  5062 webserver.cc:533] Webserver started at http://127.0.0.1:34199/ using document root <none> and password file <none>
08:03:25.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T08:03:25Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
08:03:25.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T08:03:25Z Disabled control of system clock
08:03:25.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.530897  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal
08:03:25.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data
08:03:25.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:25.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:25.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:25.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/logs
08:03:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data/info.pb
08:03:25.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:25.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:03:25.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:25.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.190:40461
08:03:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.190
08:03:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json with env {}
08:03:25.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.637351  5073 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:25.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.637550  5073 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:25.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.637605  5073 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641233  5073 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:03:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641296  5073 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641323  5073 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:03:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641346  5073 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:03:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641368  5073 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:03:25.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.641387  5073 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40921/jwks.json
08:03:25.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.645584  5073 master_runner.cc:387] Master server non-default flags:
08:03:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data
08:03:25.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.190:40461
08:03:25.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:25.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json
08:03:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data/info.pb
08:03:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.190
08:03:25.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5073
08:03:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/logs
08:03:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:03:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.647010  5073 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.648387  5073 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.655294  5081 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
08:03:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.655318  5078 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
08:03:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.655491  5079 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
08:03:25.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.656353  5073 server_base.cc:1061] running on GCE node
08:03:25.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.656950  5073 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:25.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.657982  5073 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:25.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.659147  5073 hybrid_clock.cc:648] HybridClock initialized: now 1779091405659098 us; error 63 us; skew 500 ppm
08:03:25.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.660724  5073 webserver.cc:533] Webserver started at http://127.4.241.190:43687/ using document root <none> and password file <none>
08:03:25.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.661281  5073 fs_manager.cc:362] Metadata directory not provided
08:03:25.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.661355  5073 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:25.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.661511  5073 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.663007  5073 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data/instance:
08:03:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "354f5bb557d441098c2b82735d71281e"
08:03:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.663417  5073 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal/instance:
08:03:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "354f5bb557d441098c2b82735d71281e"
08:03:25.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.666379  5073 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
08:03:25.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.668224  5087 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:25.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.669265  5073 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
08:03:25.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.669354  5073 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal
08:03:25.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "354f5bb557d441098c2b82735d71281e"
08:03:25.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.669413  5073 fs_report.cc:389] FS layout report
08:03:25.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:25.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal
08:03:25.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal
08:03:25.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data/data
08:03:25.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:25.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:25.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:25.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:25.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:25.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:25.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.700594  5073 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:25.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.701223  5073 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
08:03:25.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.701361  5073 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:25.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.708184  5073 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.190:40461
08:03:25.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.708225  5139 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.190:40461 every 8 connection(s)
08:03:25.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.709327  5073 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/data/info.pb
08:03:25.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.712159  5140 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:25.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.713469  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5073
08:03:25.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.713644  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-0/wal/instance
08:03:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.715276  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:25.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/logs
08:03:25.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data/info.pb
08:03:25.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:25.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:03:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:25.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.189:37603
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.189
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json with env {}
08:03:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.715793  5140 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.733521  5140 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.734448  5088 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.241.189:37603: connect: Connection refused (error 111)
08:03:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.735198  5140 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.189:37603: Network error: Client connection negotiation failed: client connection to 127.4.241.189:37603: connect: Connection refused (error 111)
08:03:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.784402  5140 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } attempt: 1
08:03:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.785792  5140 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.189:37603: Network error: Client connection negotiation failed: client connection to 127.4.241.189:37603: connect: Connection refused (error 111)
08:03:25.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.813303  5142 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.813485  5142 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.813527  5142 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817004  5142 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817058  5142 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817077  5142 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817093  5142 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817116  5142 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:03:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.817128  5142 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40921/jwks.json
08:03:25.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.821727  5142 master_runner.cc:387] Master server non-default flags:
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.189:37603
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json
08:03:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data/info.pb
08:03:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.189
08:03:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5142
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/logs
08:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.822732  5142 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:25.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.824097  5142 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:25.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.829818  5150 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
08:03:25.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.829815  5151 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
08:03:25.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.830209  5153 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
08:03:25.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.831194  5142 server_base.cc:1061] running on GCE node
08:03:25.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.831714  5142 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:25.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.832633  5142 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:25.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.833802  5142 hybrid_clock.cc:648] HybridClock initialized: now 1779091405833787 us; error 33 us; skew 500 ppm
08:03:25.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.835561  5142 webserver.cc:533] Webserver started at http://127.4.241.189:37201/ using document root <none> and password file <none>
08:03:25.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.836213  5142 fs_manager.cc:362] Metadata directory not provided
08:03:25.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.836275  5142 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:25.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.836508  5142 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:25.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.838212  5142 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data/instance:
08:03:25.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "888b5e67977c466bae25922e50ec870c"
08:03:25.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.838711  5142 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal/instance:
08:03:25.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "888b5e67977c466bae25922e50ec870c"
08:03:25.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.842358  5142 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.001s
08:03:25.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.844447  5159 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:25.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.845567  5142 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
08:03:25.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.845705  5142 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal
08:03:25.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "888b5e67977c466bae25922e50ec870c"
08:03:25.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:25.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.845788  5142 fs_report.cc:389] FS layout report
08:03:25.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:25.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal
08:03:25.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal
08:03:25.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data/data
08:03:25.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:25.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:25.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:25.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:25.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:25.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:25.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.853977  5140 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } attempt: 2
08:03:25.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.855304  5140 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.189:37603: Network error: Client connection negotiation failed: client connection to 127.4.241.189:37603: connect: Connection refused (error 111)
08:03:25.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.858421  5142 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:25.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.858942  5142 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
08:03:25.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.859082  5142 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:25.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.865347  5142 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.189:37603
08:03:25.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.865432  5211 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.189:37603 every 8 connection(s)
08:03:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.866253  5142 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/data/info.pb
08:03:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.868718  5212 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.870393  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5142
08:03:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.870496  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-1/wal/instance
08:03:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.871182  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal
08:03:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data
08:03:25.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/logs
08:03:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data/info.pb
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.188:34171
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.188
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json with env {}
08:03:25.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.872186  5212 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.882877  5212 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.888713  5212 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.889384  5161 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:25.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.890295  5212 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.188:34171: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:25.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.939520  5212 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } attempt: 1
08:03:25.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.941026  5212 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.188:34171: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:25.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.946456  5140 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } attempt: 3
08:03:25.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.950500  5140 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } has no permanent_uuid. Determining permanent_uuid...
08:03:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.952015  5140 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.188:34171: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:25.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.977326  5214 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:25.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.977510  5214 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:25.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.977552  5214 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:25.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980707  5214 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
08:03:25.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980757  5214 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:25.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980775  5214 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
08:03:25.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980791  5214 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
08:03:25.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980808  5214 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
08:03:25.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.980826  5214 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40921/jwks.json
08:03:25.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.983168  5140 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } attempt: 1
08:03:25.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.984459  5140 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.188:34171: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.984802  5214 master_runner.cc:387] Master server non-default flags:
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:25.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.188:34171
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
08:03:25.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40921/jwks.json
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data/info.pb
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.188
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:25.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5214
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/logs
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:25.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:25.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:25.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.986076  5214 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:25.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.987390  5214 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:25.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.993738  5222 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
08:03:25.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.993716  5225 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
08:03:25.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:25.993736  5223 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
08:03:25.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.994812  5214 server_base.cc:1061] running on GCE node
08:03:25.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.998113  5214 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:25.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:25.999100  5214 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:26.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.000252  5214 hybrid_clock.cc:648] HybridClock initialized: now 1779091406000240 us; error 30 us; skew 500 ppm
08:03:26.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.001960  5214 webserver.cc:533] Webserver started at http://127.4.241.188:38657/ using document root <none> and password file <none>
08:03:26.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.002571  5214 fs_manager.cc:362] Metadata directory not provided
08:03:26.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.002631  5214 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:26.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.002863  5214 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:26.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.004421  5214 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data/instance:
08:03:26.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fa64aa9e041e4ceb8eec5e7ee1787273"
08:03:26.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:26.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.004916  5214 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal/instance:
08:03:26.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fa64aa9e041e4ceb8eec5e7ee1787273"
08:03:26.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:26.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.008219  5214 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
08:03:26.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.009199  5212 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } attempt: 2
08:03:26.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.010576  5231 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:26.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.010565  5212 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.4.241.188:34171: Network error: Client connection negotiation failed: client connection to 127.4.241.188:34171: connect: Connection refused (error 111)
08:03:26.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.011631  5214 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
08:03:26.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.011737  5214 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal
08:03:26.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "fa64aa9e041e4ceb8eec5e7ee1787273"
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:25 on dist-test-slave-rqck"
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.011799  5214 fs_report.cc:389] FS layout report
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data/data
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:26.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:26.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:26.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.040302  5214 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.040951  5214 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
08:03:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.041091  5214 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:26.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.047623  5214 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.188:34171
08:03:26.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.047652  5283 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.188:34171 every 8 connection(s)
08:03:26.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.048671  5214 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/data/info.pb
08:03:26.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.051333  5284 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:26.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.054279  5284 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } has no permanent_uuid. Determining permanent_uuid...
08:03:26.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.057653  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5214
08:03:26.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.057752  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/master-2/wal/instance
08:03:26.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.059602  5140 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } attempt: 2
08:03:26.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.064265  5284 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } has no permanent_uuid. Determining permanent_uuid...
08:03:26.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.068396  5140 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: Bootstrap starting.
08:03:26.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.070209  5284 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } has no permanent_uuid. Determining permanent_uuid...
08:03:26.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.070950  5140 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: Neither blocks nor log segments found. Creating new log.
08:03:26.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.072014  5140 log.cc:826] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: Log is configured to *not* fsync() on all Append() calls
08:03:26.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.074368  5140 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: No bootstrap required, opened a new log
08:03:26.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.075966  5284 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: Bootstrap starting.
08:03:26.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.076776  5140 raft_consensus.cc:359] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.076908  5140 raft_consensus.cc:385] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:26.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.076946  5140 raft_consensus.cc:740] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 354f5bb557d441098c2b82735d71281e, State: Initialized, Role: FOLLOWER
08:03:26.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.077229  5140 consensus_queue.cc:260] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.077579  5293 sys_catalog.cc:455] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.077960  5293 sys_catalog.cc:458] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.078112  5284 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: Neither blocks nor log segments found. Creating new log.
08:03:26.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.078315  5140 sys_catalog.cc:565] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: configured and running, proceeding with master startup.
08:03:26.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.078773  5284 log.cc:826] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: Log is configured to *not* fsync() on all Append() calls
08:03:26.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.080363  5284 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: No bootstrap required, opened a new log
08:03:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.083726  5284 raft_consensus.cc:359] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.084204  5284 raft_consensus.cc:385] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.084488  5284 raft_consensus.cc:740] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fa64aa9e041e4ceb8eec5e7ee1787273, State: Initialized, Role: FOLLOWER
08:03:26.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.082751  5073 master_runner.cc:187] Error getting master registration for 127.4.241.189:37603: OK, instance_id { permanent_uuid: "888b5e67977c466bae25922e50ec870c" instance_seqno: 1779091405863737 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:03:26.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.084869  5073 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:03:26.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.085129  5284 consensus_queue.cc:260] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.085816  5307 sys_catalog.cc:455] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.086300  5305 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:03:26.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.086352  5305 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:03:26.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.086220  5284 sys_catalog.cc:565] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: configured and running, proceeding with master startup.
08:03:26.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.086719  5307 sys_catalog.cc:458] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.091104  5318 catalog_manager.cc:1593] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:03:26.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.091164  5318 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:03:26.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.092283  5214 master_runner.cc:187] Error getting master registration for 127.4.241.189:37603: OK, instance_id { permanent_uuid: "888b5e67977c466bae25922e50ec870c" instance_seqno: 1779091405863737 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
08:03:26.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.093787  5214 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:03:26.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.101709  5212 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } attempt: 3
08:03:26.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.108549  5212 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: Bootstrap starting.
08:03:26.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.111083  5212 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: Neither blocks nor log segments found. Creating new log.
08:03:26.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.112151  5212 log.cc:826] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: Log is configured to *not* fsync() on all Append() calls
08:03:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.113977  5212 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: No bootstrap required, opened a new log
08:03:26.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.117035  5212 raft_consensus.cc:359] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.117436  5212 raft_consensus.cc:385] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:26.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.117760  5212 raft_consensus.cc:740] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 888b5e67977c466bae25922e50ec870c, State: Initialized, Role: FOLLOWER
08:03:26.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.118402  5212 consensus_queue.cc:260] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.119254  5321 sys_catalog.cc:455] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.119647  5321 sys_catalog.cc:458] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.119803  5212 sys_catalog.cc:565] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: configured and running, proceeding with master startup.
08:03:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.127146  5142 master_runner.cc:264] No leader master found from master 888b5e67977c466bae25922e50ec870c
08:03:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.127204  5142 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
08:03:26.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.129410  5321 raft_consensus.cc:493] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:03:26.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.129833  5321 raft_consensus.cc:515] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.131592  5114 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "888b5e67977c466bae25922e50ec870c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "354f5bb557d441098c2b82735d71281e" is_pre_election: true
08:03:26.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.131825  5114 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 888b5e67977c466bae25922e50ec870c in term 0.
08:03:26.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.132426  5162 leader_election.cc:304] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [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: 354f5bb557d441098c2b82735d71281e, 888b5e67977c466bae25922e50ec870c; no voters: 
08:03:26.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.133672  5258 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "888b5e67977c466bae25922e50ec870c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" is_pre_election: true
08:03:26.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.133905  5258 raft_consensus.cc:2468] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 888b5e67977c466bae25922e50ec870c in term 0.
08:03:26.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.134676  5321 leader_election.cc:290] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 354f5bb557d441098c2b82735d71281e (127.4.241.190:40461), fa64aa9e041e4ceb8eec5e7ee1787273 (127.4.241.188:34171)
08:03:26.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.135092  5321 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Leader pre-election won for term 1
08:03:26.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.135352  5321 raft_consensus.cc:493] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:03:26.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.135624  5321 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 0 FOLLOWER]: Advancing to term 1
08:03:26.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.136911  5321 raft_consensus.cc:515] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.137774  5114 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "888b5e67977c466bae25922e50ec870c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "354f5bb557d441098c2b82735d71281e"
08:03:26.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.137889  5114 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 0 FOLLOWER]: Advancing to term 1
08:03:26.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.138913  5114 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 888b5e67977c466bae25922e50ec870c in term 1.
08:03:26.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.139674  5162 leader_election.cc:304] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [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: 354f5bb557d441098c2b82735d71281e, 888b5e67977c466bae25922e50ec870c; no voters: 
08:03:26.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.140344  5258 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "888b5e67977c466bae25922e50ec870c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273"
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.140455  5258 raft_consensus.cc:3060] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 0 FOLLOWER]: Advancing to term 1
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.141459  5258 raft_consensus.cc:2468] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 888b5e67977c466bae25922e50ec870c in term 1.
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.136945  5332 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.141677  5332 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.141891  5333 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 1 FOLLOWER]: Leader election won for term 1
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.142104  5333 raft_consensus.cc:697] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [term 1 LEADER]: Becoming Leader. State: Replica: 888b5e67977c466bae25922e50ec870c, State: Running, Role: LEADER
08:03:26.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.142424  5333 consensus_queue.cc:237] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [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: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } }
08:03:26.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.142942  5321 leader_election.cc:290] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [CANDIDATE]: Term 1 election: Requested vote from peers 354f5bb557d441098c2b82735d71281e (127.4.241.190:40461), fa64aa9e041e4ceb8eec5e7ee1787273 (127.4.241.188:34171)
08:03:26.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.144727  5321 sys_catalog.cc:455] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 888b5e67977c466bae25922e50ec870c. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.145038  5321 sys_catalog.cc:458] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: This master's current role is: LEADER
08:03:26.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.147850  5337 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
08:03:26.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.149223  5337 catalog_manager.cc:1519] Initializing Kudu cluster ID...
08:03:26.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.159737  5114 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [term 1 FOLLOWER]: Refusing update from remote peer 888b5e67977c466bae25922e50ec870c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:03:26.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.160467  5258 raft_consensus.cc:1275] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [term 1 FOLLOWER]: Refusing update from remote peer 888b5e67977c466bae25922e50ec870c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:03:26.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.161193  5335 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [LEADER]: Connected to new peer: Peer: permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:03:26.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.166077  5335 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [LEADER]: Connected to new peer: Peer: permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:03:26.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.166563  5307 sys_catalog.cc:455] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 888b5e67977c466bae25922e50ec870c. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.166661  5307 sys_catalog.cc:458] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.169958  5293 sys_catalog.cc:455] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: SysCatalogTable state changed. Reason: New leader 888b5e67977c466bae25922e50ec870c. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.170066  5293 sys_catalog.cc:458] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.180680  5321 sys_catalog.cc:455] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.180800  5321 sys_catalog.cc:458] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: This master's current role is: LEADER
08:03:26.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.181270  5293 sys_catalog.cc:455] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.181372  5293 sys_catalog.cc:458] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.182993  5341 mvcc.cc:204] Tried to move back new op lower bound from 7287158399622840320 to 7287158399562792960. Current Snapshot: MvccSnapshot[applied={T|T < 7287158399622840320}]
08:03:26.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.183954  5333 sys_catalog.cc:455] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.184060  5333 sys_catalog.cc:458] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c [sys.catalog]: This master's current role is: LEADER
08:03:26.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.185101  5307 sys_catalog.cc:455] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "888b5e67977c466bae25922e50ec870c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "354f5bb557d441098c2b82735d71281e" member_type: VOTER last_known_addr { host: "127.4.241.190" port: 40461 } } peers { permanent_uuid: "888b5e67977c466bae25922e50ec870c" member_type: VOTER last_known_addr { host: "127.4.241.189" port: 37603 } } peers { permanent_uuid: "fa64aa9e041e4ceb8eec5e7ee1787273" member_type: VOTER last_known_addr { host: "127.4.241.188" port: 34171 } } }
08:03:26.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.185201  5307 sys_catalog.cc:458] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273 [sys.catalog]: This master's current role is: FOLLOWER
08:03:26.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.185600  5339 mvcc.cc:204] Tried to move back new op lower bound from 7287158399622840320 to 7287158399562792960. Current Snapshot: MvccSnapshot[applied={T|T < 7287158399622840320}]
08:03:26.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.189349  5337 catalog_manager.cc:1382] Generated new cluster ID: 8326f02de4814817a439e6ee105a142d
08:03:26.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.189415  5337 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
08:03:26.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.208492  5337 catalog_manager.cc:1405] Generated new certificate authority record
08:03:26.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.209988  5337 catalog_manager.cc:1539] Loading token signing keys...
08:03:26.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.243275  5337 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 888b5e67977c466bae25922e50ec870c: Generated new TSK 0
08:03:26.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.244340  5337 catalog_manager.cc:1549] Initializing in-progress tserver states...
08:03:26.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.265381  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/logs
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data/info.pb
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.129:0
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.129
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.129
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:03:26.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.411504  5346 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:26.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.411703  5346 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:26.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.411746  5346 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:26.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.414942  5346 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:26.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.415046  5346 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.241.129
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.419024  5346 tablet_server_runner.cc:78] Tablet server non-default flags:
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.129:0
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data/info.pb
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.129
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:26.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5346
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.129
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/logs
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:26.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:26.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.420029  5346 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:26.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.421111  5346 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:26.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.427106  5354 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
08:03:26.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.427094  5352 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
08:03:26.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.427114  5351 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
08:03:26.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.427630  5346 server_base.cc:1061] running on GCE node
08:03:26.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.427982  5346 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:26.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.428517  5346 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:26.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.429678  5346 hybrid_clock.cc:648] HybridClock initialized: now 1779091406429663 us; error 36 us; skew 500 ppm
08:03:26.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.431329  5346 webserver.cc:533] Webserver started at http://127.4.241.129:39469/ using document root <none> and password file <none>
08:03:26.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.431888  5346 fs_manager.cc:362] Metadata directory not provided
08:03:26.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.431945  5346 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:26.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.432160  5346 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.433719  5346 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data/instance:
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "90a273b1070740579b88cb12afd82d95"
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.434196  5346 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal/instance:
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "90a273b1070740579b88cb12afd82d95"
08:03:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.437184  5346 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
08:03:26.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.439512  5360 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:26.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.440464  5346 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.440598  5346 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "90a273b1070740579b88cb12afd82d95"
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.440693  5346 fs_report.cc:389] FS layout report
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data/data
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:26.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:26.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:26.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:26.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:26.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:26.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:26.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.452256  5346 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:26.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.452930  5346 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
08:03:26.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.453104  5346 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:26.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.453745  5346 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:03:26.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.454722  5346 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:03:26.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.454767  5346 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:03:26.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.454802  5346 ts_tablet_manager.cc:616] Registered 0 tablets
08:03:26.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.454816  5346 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:03:26.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.463342  5346 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.129:38905
08:03:26.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.463378  5473 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.129:38905 every 8 connection(s)
08:03:26.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.464164  5346 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/data/info.pb
08:03:26.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.472441  5475 heartbeater.cc:344] Connected to a master server at 127.4.241.190:40461
08:03:26.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.472663  5475 heartbeater.cc:461] Registering TS with master...
08:03:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473091  5475 heartbeater.cc:507] Master 127.4.241.190:40461 requested a full tablet report, sending...
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473492  5474 heartbeater.cc:344] Connected to a master server at 127.4.241.188:34171
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473510  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5346
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473562  5474 heartbeater.cc:461] Registering TS with master...
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473590  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-0/wal/instance
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.473762  5474 heartbeater.cc:507] Master 127.4.241.188:34171 requested a full tablet report, sending...
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.474354  5476 heartbeater.cc:344] Connected to a master server at 127.4.241.189:37603
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.474439  5476 heartbeater.cc:461] Registering TS with master...
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.474598  5476 heartbeater.cc:507] Master 127.4.241.189:37603 requested a full tablet report, sending...
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.474586  5104 ts_manager.cc:194] Registered new tserver with Master: 90a273b1070740579b88cb12afd82d95 (127.4.241.129:38905)
08:03:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.474776  5248 ts_manager.cc:194] Registered new tserver with Master: 90a273b1070740579b88cb12afd82d95 (127.4.241.129:38905)
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.476243  5175 ts_manager.cc:194] Registered new tserver with Master: 90a273b1070740579b88cb12afd82d95 (127.4.241.129:38905)
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.476586  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data
08:03:26.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/logs
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data/info.pb
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:26.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.130:0
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.130
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.130
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:03:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.477780  5175 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.241.129:56715
08:03:26.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.573127  5481 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:26.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.573311  5481 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:26.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.573364  5481 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:26.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.576704  5481 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:26.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.576799  5481 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.241.130
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.580485  5481 tablet_server_runner.cc:78] Tablet server non-default flags:
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.130:0
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data/info.pb
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.130
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5481
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.130
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/logs
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:26.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.581408  5481 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:26.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.582427  5481 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:26.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.588160  5489 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
08:03:26.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.588219  5486 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
08:03:26.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.588267  5487 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
08:03:26.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.588423  5481 server_base.cc:1061] running on GCE node
08:03:26.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.589144  5481 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:26.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.589689  5481 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:26.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.590837  5481 hybrid_clock.cc:648] HybridClock initialized: now 1779091406590813 us; error 38 us; skew 500 ppm
08:03:26.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.592553  5481 webserver.cc:533] Webserver started at http://127.4.241.130:33127/ using document root <none> and password file <none>
08:03:26.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.593108  5481 fs_manager.cc:362] Metadata directory not provided
08:03:26.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.593164  5481 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:26.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.593386  5481 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.594877  5481 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data/instance:
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9a55d9bb8eab4b36bb356360a1ec8306"
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.595371  5481 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal/instance:
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9a55d9bb8eab4b36bb356360a1ec8306"
08:03:26.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.598489  5481 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.000s	sys 0.004s
08:03:26.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.600533  5495 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:26.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.601462  5481 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
08:03:26.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.601563  5481 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal
08:03:26.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9a55d9bb8eab4b36bb356360a1ec8306"
08:03:26.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.601675  5481 fs_report.cc:389] FS layout report
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data/data
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:26.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:26.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:26.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:26.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:26.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:26.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:26.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.622859  5481 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:26.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.623574  5481 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
08:03:26.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.623755  5481 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:26.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.624416  5481 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:03:26.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.625452  5481 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:03:26.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.625500  5481 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:03:26.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.625550  5481 ts_tablet_manager.cc:616] Registered 0 tablets
08:03:26.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.625571  5481 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:03:26.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.634374  5481 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.130:37645
08:03:26.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.634411  5608 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.130:37645 every 8 connection(s)
08:03:26.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.635282  5481 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/data/info.pb
08:03:26.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.641989  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5481
08:03:26.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.642086  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-1/wal/instance
08:03:26.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.644732  5609 heartbeater.cc:344] Connected to a master server at 127.4.241.188:34171
08:03:26.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.644965  5609 heartbeater.cc:461] Registering TS with master...
08:03:26.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.645442  5609 heartbeater.cc:507] Master 127.4.241.188:34171 requested a full tablet report, sending...
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.645958  5610 heartbeater.cc:344] Connected to a master server at 127.4.241.190:40461
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.646031  5610 heartbeater.cc:461] Registering TS with master...
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.646114  5062 external_mini_cluster.cc:1366] Running /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/logs
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data/info.pb
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
08:03:26.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.131:0
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.131
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.131
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.646207  5610 heartbeater.cc:507] Master 127.4.241.190:40461 requested a full tablet report, sending...
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.646590  5247 ts_manager.cc:194] Registered new tserver with Master: 9a55d9bb8eab4b36bb356360a1ec8306 (127.4.241.130:37645)
08:03:26.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.646914  5103 ts_manager.cc:194] Registered new tserver with Master: 9a55d9bb8eab4b36bb356360a1ec8306 (127.4.241.130:37645)
08:03:26.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.648411  5611 heartbeater.cc:344] Connected to a master server at 127.4.241.189:37603
08:03:26.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.648483  5611 heartbeater.cc:461] Registering TS with master...
08:03:26.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.648672  5611 heartbeater.cc:507] Master 127.4.241.189:37603 requested a full tablet report, sending...
08:03:26.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.649250  5175 ts_manager.cc:194] Registered new tserver with Master: 9a55d9bb8eab4b36bb356360a1ec8306 (127.4.241.130:37645)
08:03:26.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.649821  5175 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.241.130:43353
08:03:26.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.744973  5616 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
08:03:26.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.745139  5616 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
08:03:26.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.745177  5616 flags.cc:432] Enabled unsafe flag: --never_fsync=true
08:03:26.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.748324  5616 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
08:03:26.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.748420  5616 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.241.131
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.752087  5616 tablet_server_runner.cc:78] Tablet server non-default flags:
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.4.241.148:37347
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.4.241.131:0
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data/info.pb
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.4.241.131
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.4.241.190:40461,127.4.241.189:37603,127.4.241.188:34171
08:03:26.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5616
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.4.241.131
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/logs
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 07:43:18 UTC on bdcb31816ec0
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11952
08:03:26.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.753031  5616 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
08:03:26.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.754033  5616 file_cache.cc:492] Constructed file cache file cache with capacity 419430
08:03:26.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.759904  5621 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
08:03:26.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.759938  5616 server_base.cc:1061] running on GCE node
08:03:26.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.759892  5622 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
08:03:26.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:26.759895  5624 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
08:03:26.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.760423  5616 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
08:03:26.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.760882  5616 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
08:03:26.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.762027  5616 hybrid_clock.cc:648] HybridClock initialized: now 1779091406762006 us; error 29 us; skew 500 ppm
08:03:26.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.763608  5616 webserver.cc:533] Webserver started at http://127.4.241.131:33503/ using document root <none> and password file <none>
08:03:26.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.764122  5616 fs_manager.cc:362] Metadata directory not provided
08:03:26.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.764180  5616 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
08:03:26.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.764395  5616 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.765863  5616 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data/instance:
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "10dec760b0974058b46c34d18598cd37"
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.766335  5616 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal/instance:
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "10dec760b0974058b46c34d18598cd37"
08:03:26.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.769743  5616 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
08:03:26.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.771589  5630 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
08:03:26.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.772418  5616 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
08:03:26.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.772528  5616 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data,/tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal
08:03:26.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "10dec760b0974058b46c34d18598cd37"
08:03:26.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 08:03:26 on dist-test-slave-rqck"
08:03:26.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.772629  5616 fs_report.cc:389] FS layout report
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data/data
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
08:03:26.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
08:03:26.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.791779  5616 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
08:03:26.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.792418  5616 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
08:03:26.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.792621  5616 kserver.cc:163] Server-wide thread pool size limit: 3276
08:03:26.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.793179  5616 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
08:03:26.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.794461  5616 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
08:03:26.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.794521  5616 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
08:03:26.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.794582  5616 ts_tablet_manager.cc:616] Registered 0 tablets
08:03:26.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.794605  5616 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
08:03:26.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.804253  5616 rpc_server.cc:307] RPC server started. Bound to: 127.4.241.131:44059
08:03:26.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.804282  5743 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.241.131:44059 every 8 connection(s)
08:03:26.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.805140  5616 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/data/info.pb
08:03:26.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.811697  5062 external_mini_cluster.cc:1428] Started /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu as pid 5616
08:03:26.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.812369  5062 external_mini_cluster.cc:1442] Reading /tmp/dist-test-tasksvLHYa/test-tmp/mini-kudu-cluster5120779724344011588/ts-2/wal/instance
08:03:26.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814106  5744 heartbeater.cc:344] Connected to a master server at 127.4.241.188:34171
08:03:26.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814116  5746 heartbeater.cc:344] Connected to a master server at 127.4.241.189:37603
08:03:26.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814356  5744 heartbeater.cc:461] Registering TS with master...
08:03:26.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814356  5746 heartbeater.cc:461] Registering TS with master...
08:03:26.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814647  5745 heartbeater.cc:344] Connected to a master server at 127.4.241.190:40461
08:03:26.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814736  5745 heartbeater.cc:461] Registering TS with master...
08:03:26.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814929  5746 heartbeater.cc:507] Master 127.4.241.189:37603 requested a full tablet report, sending...
08:03:26.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814929  5744 heartbeater.cc:507] Master 127.4.241.188:34171 requested a full tablet report, sending...
08:03:26.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.814934  5745 heartbeater.cc:507] Master 127.4.241.190:40461 requested a full tablet report, sending...
08:03:26.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.815938  5175 ts_manager.cc:194] Registered new tserver with Master: 10dec760b0974058b46c34d18598cd37 (127.4.241.131:44059)
08:03:26.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.815986  5247 ts_manager.cc:194] Registered new tserver with Master: 10dec760b0974058b46c34d18598cd37 (127.4.241.131:44059)
08:03:26.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.816061  5103 ts_manager.cc:194] Registered new tserver with Master: 10dec760b0974058b46c34d18598cd37 (127.4.241.131:44059)
08:03:26.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.816648  5175 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.241.131:51429
08:03:26.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:26.818944  5062 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
08:03:26.819 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
08:03:26.821 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

08:03:26.829 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.241.190"
      port: 40461
    }
    bound_http_address {
      host: "127.4.241.190"
      port: 43687
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.241.189"
      port: 37603
    }
    bound_http_address {
      host: "127.4.241.189"
      port: 37201
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.241.188"
      port: 34171
    }
    bound_http_address {
      host: "127.4.241.188"
      port: 38657
    }
  }
}

08:03:26.832 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

08:03:26.834 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.4.241.129"
      port: 38905
    }
    bound_http_address {
      host: "127.4.241.129"
      port: 39469
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.4.241.130"
      port: 37645
    }
    bound_http_address {
      host: "127.4.241.130"
      port: 33127
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.4.241.131"
      port: 44059
    }
    bound_http_address {
      host: "127.4.241.131"
      port: 33503
    }
  }
}

08:03:26.835 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
08:03:27.004 [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)
08:03:27.066 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
08:03:27.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.087558  5305 catalog_manager.cc:1294] Loaded cluster ID: 8326f02de4814817a439e6ee105a142d
08:03:27.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.087638  5305 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: loading cluster ID for follower catalog manager: success
08:03:27.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.089437  5305 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: acquiring CA information for follower catalog manager: success
08:03:27.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.090517  5305 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 354f5bb557d441098c2b82735d71281e: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:03:27.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.092370  5318 catalog_manager.cc:1294] Loaded cluster ID: 8326f02de4814817a439e6ee105a142d
08:03:27.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.092447  5318 catalog_manager.cc:1587] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: loading cluster ID for follower catalog manager: success
08:03:27.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.094928  5318 catalog_manager.cc:1609] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: acquiring CA information for follower catalog manager: success
08:03:27.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.096181  5318 catalog_manager.cc:1637] T 00000000000000000000000000000000 P fa64aa9e041e4ceb8eec5e7ee1787273: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
08:03:27.205 [DEBUG - main] (Connection.java:748) [peer master-127.4.241.190:40461(127.4.241.190:40461)] connecting to peer
08:03:27.250 [DEBUG - main] (Connection.java:748) [peer master-127.4.241.189:37603(127.4.241.189:37603)] connecting to peer
08:03:27.254 [DEBUG - main] (Connection.java:748) [peer master-127.4.241.188:34171(127.4.241.188:34171)] connecting to peer
08:03:27.267 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.4.241.188:34171(127.4.241.188:34171)] Successfully connected to peer
08:03:27.267 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.4.241.190:40461(127.4.241.190:40461)] Successfully connected to peer
08:03:27.267 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.4.241.189:37603(127.4.241.189:37603)] Successfully connected to peer
08:03:27.348 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.241.190
08:03:27.350 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.241.188
08:03:27.357 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.4.241.189
08:03:27.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.479688  5476 heartbeater.cc:499] Master 127.4.241.189:37603 was elected leader, sending a full tablet report...
08:03:27.557 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xe753b3c7, L:/127.0.0.1:58252 - R:/127.4.241.188:34171] using SASL/PLAIN
08:03:27.557 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x877a5fa3, L:/127.0.0.1:56706 - R:/127.4.241.190:40461] using SASL/PLAIN
08:03:27.557 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xc45f6f80, L:/127.0.0.1:52314 - R:/127.4.241.189:37603] using SASL/PLAIN
08:03:27.589 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
08:03:27.590 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=417), Traces: [0ms] refreshing cache from master, [21ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.241.190:40461, [75ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.241.189:37603, [79ms] Sub RPC ConnectToMaster: sending RPC to server master-127.4.241.188:34171, [393ms] Sub RPC ConnectToMaster: received response from server master-127.4.241.190:40461: OK, [394ms] Sub RPC ConnectToMaster: received response from server master-127.4.241.188:34171: OK, [394ms] Sub RPC ConnectToMaster: received response from server master-127.4.241.189:37603: OK, deferred=null) after lookup
08:03:27.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.640517  5175 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:52314:
08:03:27.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1779091405079"
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
08:03:27.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:27.643765  5175 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-1779091405079 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
08:03:27.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.651113  5611 heartbeater.cc:499] Master 127.4.241.189:37603 was elected leader, sending a full tablet report...
08:03:27.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.664523  5678 tablet_service.cc:1511] Processing CreateTablet for tablet 9fbd9683d8b74473906912b12f9eb19b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779091405079 [id=217696e29cf8493aac4585446bbd39e9]), partition=RANGE (key) PARTITION UNBOUNDED
08:03:27.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.664791  5408 tablet_service.cc:1511] Processing CreateTablet for tablet 9fbd9683d8b74473906912b12f9eb19b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779091405079 [id=217696e29cf8493aac4585446bbd39e9]), partition=RANGE (key) PARTITION UNBOUNDED
08:03:27.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.665560  5678 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 9fbd9683d8b74473906912b12f9eb19b. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:27.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.665661  5408 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 9fbd9683d8b74473906912b12f9eb19b. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:27.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.667369  5543 tablet_service.cc:1511] Processing CreateTablet for tablet 9fbd9683d8b74473906912b12f9eb19b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779091405079 [id=217696e29cf8493aac4585446bbd39e9]), partition=RANGE (key) PARTITION UNBOUNDED
08:03:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.668215  5543 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 9fbd9683d8b74473906912b12f9eb19b. 1 dirs total, 0 dirs full, 0 dirs failed
08:03:27.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.671962  5774 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Bootstrap starting.
08:03:27.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.674036  5773 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Bootstrap starting.
08:03:27.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.674522  5774 tablet_bootstrap.cc:654] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Neither blocks nor log segments found. Creating new log.
08:03:27.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.675870  5774 log.cc:826] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Log is configured to *not* fsync() on all Append() calls
08:03:27.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.676167  5773 tablet_bootstrap.cc:654] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Neither blocks nor log segments found. Creating new log.
08:03:27.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.676986  5773 log.cc:826] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Log is configured to *not* fsync() on all Append() calls
08:03:27.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.677642  5775 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Bootstrap starting.
08:03:27.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.677809  5774 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: No bootstrap required, opened a new log
08:03:27.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.677985  5774 ts_tablet_manager.cc:1403] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Time spent bootstrapping tablet: real 0.006s	user 0.005s	sys 0.000s
08:03:27.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.679569  5775 tablet_bootstrap.cc:654] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Neither blocks nor log segments found. Creating new log.
08:03:27.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.680619  5775 log.cc:826] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Log is configured to *not* fsync() on all Append() calls
08:03:27.681 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 217696e29cf8493aac4585446bbd39e9
08:03:27.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.681062  5774 raft_consensus.cc:359] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.681455  5774 raft_consensus.cc:385] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:27.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.681679  5774 raft_consensus.cc:740] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 10dec760b0974058b46c34d18598cd37, State: Initialized, Role: FOLLOWER
08:03:27.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.682333  5774 consensus_queue.cc:260] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [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: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.682638  5773 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: No bootstrap required, opened a new log
08:03:27.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.682745  5775 tablet_bootstrap.cc:492] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: No bootstrap required, opened a new log
08:03:27.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.682857  5773 ts_tablet_manager.cc:1403] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Time spent bootstrapping tablet: real 0.009s	user 0.004s	sys 0.000s
08:03:27.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.682931  5775 ts_tablet_manager.cc:1403] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Time spent bootstrapping tablet: real 0.005s	user 0.000s	sys 0.003s
08:03:27.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.683698  5774 ts_tablet_manager.cc:1434] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Time spent starting tablet: real 0.006s	user 0.004s	sys 0.000s
08:03:27.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.686071  5775 raft_consensus.cc:359] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.686326  5746 heartbeater.cc:499] Master 127.4.241.189:37603 was elected leader, sending a full tablet report...
08:03:27.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.686568  5775 raft_consensus.cc:385] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:27.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.686795  5775 raft_consensus.cc:740] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9a55d9bb8eab4b36bb356360a1ec8306, State: Initialized, Role: FOLLOWER
08:03:27.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.686859  5773 raft_consensus.cc:359] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.687227  5773 raft_consensus.cc:385] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
08:03:27.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.687386  5775 consensus_queue.cc:260] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [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: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.687937  5773 raft_consensus.cc:740] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 90a273b1070740579b88cb12afd82d95, State: Initialized, Role: FOLLOWER
08:03:27.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.688230  5775 ts_tablet_manager.cc:1434] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Time spent starting tablet: real 0.005s	user 0.004s	sys 0.001s
08:03:27.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.688565  5773 consensus_queue.cc:260] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [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: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.689512  5773 ts_tablet_manager.cc:1434] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Time spent starting tablet: real 0.007s	user 0.006s	sys 0.000s
08:03:27.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:27.715981  5477 tablet.cc:2404] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:03:27.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:27.806819  5747 tablet.cc:2404] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:03:27.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.813920  5781 raft_consensus.cc:493] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
08:03:27.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.814090  5781 raft_consensus.cc:515] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.815096  5781 leader_election.cc:290] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 10dec760b0974058b46c34d18598cd37 (127.4.241.131:44059), 9a55d9bb8eab4b36bb356360a1ec8306 (127.4.241.130:37645)
08:03:27.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.819330  5563 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "9fbd9683d8b74473906912b12f9eb19b" candidate_uuid: "90a273b1070740579b88cb12afd82d95" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" is_pre_election: true
08:03:27.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.819603  5563 raft_consensus.cc:2468] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 90a273b1070740579b88cb12afd82d95 in term 0.
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820119  5364 leader_election.cc:304] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [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: 90a273b1070740579b88cb12afd82d95, 9a55d9bb8eab4b36bb356360a1ec8306; no voters: 
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820218  5698 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "9fbd9683d8b74473906912b12f9eb19b" candidate_uuid: "90a273b1070740579b88cb12afd82d95" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "10dec760b0974058b46c34d18598cd37" is_pre_election: true
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820400  5781 raft_consensus.cc:2804] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Leader pre-election won for term 1
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820457  5781 raft_consensus.cc:493] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820452  5698 raft_consensus.cc:2468] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 90a273b1070740579b88cb12afd82d95 in term 0.
08:03:27.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.820493  5781 raft_consensus.cc:3060] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 0 FOLLOWER]: Advancing to term 1
08:03:27.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.821575  5781 raft_consensus.cc:515] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.821981  5781 leader_election.cc:290] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [CANDIDATE]: Term 1 election: Requested vote from peers 10dec760b0974058b46c34d18598cd37 (127.4.241.131:44059), 9a55d9bb8eab4b36bb356360a1ec8306 (127.4.241.130:37645)
08:03:27.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.822284  5698 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "9fbd9683d8b74473906912b12f9eb19b" candidate_uuid: "90a273b1070740579b88cb12afd82d95" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "10dec760b0974058b46c34d18598cd37"
08:03:27.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.822371  5698 raft_consensus.cc:3060] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 0 FOLLOWER]: Advancing to term 1
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.823331  5698 raft_consensus.cc:2468] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 90a273b1070740579b88cb12afd82d95 in term 1.
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.823691  5363 leader_election.cc:304] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [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: 10dec760b0974058b46c34d18598cd37, 90a273b1070740579b88cb12afd82d95; no voters: 
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.823957  5563 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "9fbd9683d8b74473906912b12f9eb19b" candidate_uuid: "90a273b1070740579b88cb12afd82d95" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "9a55d9bb8eab4b36bb356360a1ec8306"
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.824074  5563 raft_consensus.cc:3060] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 0 FOLLOWER]: Advancing to term 1
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.824681  5781 raft_consensus.cc:2804] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 1 FOLLOWER]: Leader election won for term 1
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.824890  5781 raft_consensus.cc:697] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [term 1 LEADER]: Becoming Leader. State: Replica: 90a273b1070740579b88cb12afd82d95, State: Running, Role: LEADER
08:03:27.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.825091  5563 raft_consensus.cc:2468] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 90a273b1070740579b88cb12afd82d95 in term 1.
08:03:27.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.825210  5781 consensus_queue.cc:237] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [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: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } }
08:03:27.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.828938  5176 catalog_manager.cc:5696] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 reported cstate change: term changed from 0 to 1, leader changed from <none> to 90a273b1070740579b88cb12afd82d95 (127.4.241.129). New cstate: current_term: 1 leader_uuid: "90a273b1070740579b88cb12afd82d95" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "90a273b1070740579b88cb12afd82d95" member_type: VOTER last_known_addr { host: "127.4.241.129" port: 38905 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 } health_report { overall_health: UNKNOWN } } }
08:03:27.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 08:03:27.887748  5612 tablet.cc:2404] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306: Can't schedule compaction. Clean time has not been advanced past its initial value.
08:03:27.893 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 9fbd9683d8b74473906912b12f9eb19b for table 'org.apache.kudu.client.TestHybridTime-1779091405079' with partition [<start>, <end>)
08:03:27.899 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=9fbd9683d8b74473906912b12f9eb19b@[10dec760b0974058b46c34d18598cd37(127.4.241.131:44059),90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)[L],9a55d9bb8eab4b36bb356360a1ec8306(127.4.241.130:37645)]}]
08:03:27.900 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=16), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.4.241.189:37603, [7ms] Sub RPC GetTableLocations: received response from server master-127.4.241.189:37603: OK, deferred=null) after lookup
08:03:27.909 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)] connecting to peer
08:03:27.911 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)] Successfully connected to peer
08:03:27.973 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x2ab33e99, L:/127.0.0.1:37952 - R:/127.4.241.129:38905] using TOKEN/null
08:03:27.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.980741  5563 raft_consensus.cc:1275] T 9fbd9683d8b74473906912b12f9eb19b P 9a55d9bb8eab4b36bb356360a1ec8306 [term 1 FOLLOWER]: Refusing update from remote peer 90a273b1070740579b88cb12afd82d95: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:03:27.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.980890  5698 raft_consensus.cc:1275] T 9fbd9683d8b74473906912b12f9eb19b P 10dec760b0974058b46c34d18598cd37 [term 1 FOLLOWER]: Refusing update from remote peer 90a273b1070740579b88cb12afd82d95: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
08:03:27.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.981490  5784 consensus_queue.cc:1048] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [LEADER]: Connected to new peer: Peer: permanent_uuid: "9a55d9bb8eab4b36bb356360a1ec8306" member_type: VOTER last_known_addr { host: "127.4.241.130" port: 37645 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:03:27.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.981837  5781 consensus_queue.cc:1048] T 9fbd9683d8b74473906912b12f9eb19b P 90a273b1070740579b88cb12afd82d95 [LEADER]: Connected to new peer: Peer: permanent_uuid: "10dec760b0974058b46c34d18598cd37" member_type: VOTER last_known_addr { host: "127.4.241.131" port: 44059 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
08:03:27.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:27.990484  5789 mvcc.cc:204] Tried to move back new op lower bound from 7287158407081750528 to 7287158406455459840. Current Snapshot: MvccSnapshot[applied={T|T < 7287158407081750528}]
08:03:28.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.005023  5791 mvcc.cc:204] Tried to move back new op lower bound from 7287158407081750528 to 7287158406455459840. Current Snapshot: MvccSnapshot[applied={T|T < 7287158407081750528}]
08:03:28.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.007858  5790 mvcc.cc:204] Tried to move back new op lower bound from 7287158407081750528 to 7287158406455459840. Current Snapshot: MvccSnapshot[applied={T|T < 7287158407081750528}]
08:03:28.035 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.045 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.059 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.062 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@999035250(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:03:28.072 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.073 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@116065663(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:03:28.079 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.079 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@446568444(state=PENDING, result=null, callback=<none>, errback=<none>)}
08:03:28.085 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
08:03:28.128 [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-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.135 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7287158427561750529) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.138 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7287158427561750533) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.142 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7287158427561750537) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.146 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7287158427561750541) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.149 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7287158427561750545) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.152 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7287158427561750549) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.156 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7287158427561750550) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779091405079, tablet=9fbd9683d8b74473906912b12f9eb19b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
08:03:28.159 [DEBUG - main] (Connection.java:575) [peer master-127.4.241.188:34171(127.4.241.188:34171)] disconnecting while in state READY
08:03:28.159 [DEBUG - main] (Connection.java:575) [peer master-127.4.241.189:37603(127.4.241.189:37603)] disconnecting while in state READY
08:03:28.160 [DEBUG - main] (Connection.java:575) [peer master-127.4.241.190:40461(127.4.241.190:40461)] disconnecting while in state READY
08:03:28.160 [DEBUG - main] (Connection.java:575) [peer 90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)] disconnecting while in state READY
08:03:28.165 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.4.241.188:34171(127.4.241.188:34171)] handling channelInactive
08:03:28.165 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.4.241.190:40461(127.4.241.190:40461)] handling channelInactive
08:03:28.165 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.4.241.188:34171(127.4.241.188:34171)] cleaning up while in state READY due to: connection closed
08:03:28.165 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.4.241.190:40461(127.4.241.190:40461)] cleaning up while in state READY due to: connection closed
08:03:28.166 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.4.241.189:37603(127.4.241.189:37603)] handling channelInactive
08:03:28.166 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.4.241.189:37603(127.4.241.189:37603)] cleaning up while in state READY due to: connection closed
08:03:28.166 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
08:03:28.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.170483  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5346
08:03:28.171 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)] handling channelInactive
08:03:28.172 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 90a273b1070740579b88cb12afd82d95(127.4.241.129:38905)] cleaning up while in state READY due to: connection closed
08:03:28.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.177487  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5481
08:03:28.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.182894  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5616
08:03:28.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.188143  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5073
08:03:28.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.193815  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5142
08:03:28.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 08:03:28.199380  5062 external_mini_cluster.cc:1658] Killing /tmp/dist-test-tasksvLHYa/build/debug/bin/kudu with pid 5214
08:03:28.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T08:03:28Z chronyd exiting

Time: 3.28

OK (1 test)

