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

20:02:59.349 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:02:59.351 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

20:02:59.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.353010  7097 mini_oidc.cc:150] Starting JWKS server
20:02:59.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.355576  7097 webserver.cc:533] Webserver started at http://127.0.0.1:41709/ using document root <none> and password file <none>
20:02:59.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.355820  7097 mini_oidc.cc:186] Starting OIDC Discovery server
20:02:59.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.356158  7097 webserver.cc:533] Webserver started at http://127.0.0.1:37149/ using document root <none> and password file <none>
20:02:59.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:02:59Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
20:02:59.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:02:59Z Disabled control of system clock
20:02:59.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.376840  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal
20:02:59.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data
20:02:59.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:02:59.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:02:59.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:02:59.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/logs
20:02:59.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data/info.pb
20:02:59.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:02:59.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:02:59.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:02:59.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:02:59.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:02:59.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:02:59.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.126:41803
20:02:59.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.126
20:02:59.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json with env {}
20:02:59.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.519896  7108 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:02:59.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.520135  7108 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:02:59.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.520190  7108 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:02:59.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.523991  7108 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:02:59.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.524062  7108 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:02:59.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.524084  7108 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:02:59.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.524102  7108 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:02:59.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.524120  7108 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:02:59.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.524135  7108 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:41709/jwks.json
20:02:59.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.528751  7108 master_runner.cc:387] Master server non-default flags:
20:02:59.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data
20:02:59.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.126:41803
20:02:59.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:02:59.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json
20:02:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data/info.pb
20:02:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.126
20:02:59.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:02:59.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7108
20:02:59.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:02:59.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:02:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/logs
20:02:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:02:59.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:02:59.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:02:59.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:02:59.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:02:59.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:02:59.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:02:59.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:02:59.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.530699  7108 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:02:59.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.532294  7108 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:02:59.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.539896  7114 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
20:02:59.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.539925  7113 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
20:02:59.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.540136  7108 server_base.cc:1061] running on GCE node
20:02:59.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.540019  7116 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
20:02:59.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.541124  7108 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:02:59.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.542366  7108 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:02:59.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.543509  7108 hybrid_clock.cc:648] HybridClock initialized: now 1783540979543491 us; error 43 us; skew 500 ppm
20:02:59.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.545733  7108 webserver.cc:533] Webserver started at http://127.6.238.126:44509/ using document root <none> and password file <none>
20:02:59.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.546381  7108 fs_manager.cc:362] Metadata directory not provided
20:02:59.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.546440  7108 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:02:59.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.546618  7108 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:02:59.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.548301  7108 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data/instance:
20:02:59.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "753095580b85456eb1e079b93e8b275e"
20:02:59.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.548818  7108 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal/instance:
20:02:59.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "753095580b85456eb1e079b93e8b275e"
20:02:59.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.552696  7108 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
20:02:59.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.555418  7122 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:02:59.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.556697  7108 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
20:02:59.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.556854  7108 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal
20:02:59.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "753095580b85456eb1e079b93e8b275e"
20:02:59.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.556978  7108 fs_report.cc:389] FS layout report
20:02:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:02:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal
20:02:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal
20:02:59.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data/data
20:02:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:02:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:02:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:02:59.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:02:59.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:02:59.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:02:59.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:02:59.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:02:59.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:02:59.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:02:59.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:02:59.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.583670  7108 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:02:59.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.584581  7108 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:02:59.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.584789  7108 kserver.cc:163] Server-wide thread pool size limit: 3276
20:02:59.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.592983  7108 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.126:41803
20:02:59.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.592993  7174 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.126:41803 every 8 connection(s)
20:02:59.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.594347  7108 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/data/info.pb
20:02:59.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.598626  7175 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:02:59.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.603138  7175 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.604707  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7108
20:02:59.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.604951  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-0/wal/instance
20:02:59.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.606719  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal
20:02:59.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data
20:02:59.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:02:59.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:02:59.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:02:59.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/logs
20:02:59.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data/info.pb
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:02:59.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:02:59.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:02:59.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.125:35035
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.125
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json with env {}
20:02:59.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.619347  7175 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.620172  7126 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.6.238.125:35035: connect: Connection refused (error 111)
20:02:59.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.621178  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.125:35035: Network error: Client connection negotiation failed: client connection to 127.6.238.125:35035: connect: Connection refused (error 111)
20:02:59.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.670459  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } attempt: 1
20:02:59.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.672513  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.125:35035: Network error: Client connection negotiation failed: client connection to 127.6.238.125:35035: connect: Connection refused (error 111)
20:02:59.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.717528  7179 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:02:59.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.717777  7179 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:02:59.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.717823  7179 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:02:59.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721470  7179 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:02:59.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721541  7179 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:02:59.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721562  7179 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:02:59.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721580  7179 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:02:59.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721599  7179 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:02:59.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.721613  7179 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:41709/jwks.json
20:02:59.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.725965  7179 master_runner.cc:387] Master server non-default flags:
20:02:59.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data
20:02:59.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal
20:02:59.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.125:35035
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:02:59.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data/info.pb
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.125
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:02:59.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7179
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/logs
20:02:59.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:02:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:02:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:02:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:02:59.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:02:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:02:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:02:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:02:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.727116  7179 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:02:59.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.728286  7179 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:02:59.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.735343  7188 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
20:02:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.735432  7186 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
20:02:59.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.735507  7185 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
20:02:59.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.735865  7179 server_base.cc:1061] running on GCE node
20:02:59.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.736742  7179 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:02:59.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.738032  7179 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:02:59.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.739224  7179 hybrid_clock.cc:648] HybridClock initialized: now 1783540979739233 us; error 147 us; skew 500 ppm
20:02:59.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.740775  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } attempt: 2
20:02:59.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.741816  7179 webserver.cc:533] Webserver started at http://127.6.238.125:39055/ using document root <none> and password file <none>
20:02:59.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.742619  7179 fs_manager.cc:362] Metadata directory not provided
20:02:59.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.742703  7179 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:02:59.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.742937  7179 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:02:59.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.745191  7179 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data/instance:
20:02:59.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d82e56b8e9a34149b6b3a7a571a51ce8"
20:02:59.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.745505  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.125:35035: Network error: Client connection negotiation failed: client connection to 127.6.238.125:35035: connect: Connection refused (error 111)
20:02:59.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.746884  7179 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal/instance:
20:02:59.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d82e56b8e9a34149b6b3a7a571a51ce8"
20:02:59.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.751602  7179 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
20:02:59.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.754695  7194 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:02:59.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.756403  7179 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
20:02:59.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.756533  7179 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal
20:02:59.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d82e56b8e9a34149b6b3a7a571a51ce8"
20:02:59.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.756621  7179 fs_report.cc:389] FS layout report
20:02:59.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data/data
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:02:59.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:02:59.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:02:59.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:02:59.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:02:59.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.772851  7179 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:02:59.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.773729  7179 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:02:59.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.773887  7179 kserver.cc:163] Server-wide thread pool size limit: 3276
20:02:59.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.781870  7179 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.125:35035
20:02:59.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.781850  7246 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.125:35035 every 8 connection(s)
20:02:59.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.783125  7179 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/data/info.pb
20:02:59.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.784489  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7179
20:02:59.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.784596  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-1/wal/instance
20:02:59.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.785401  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:02:59.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/logs
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data/info.pb
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:02:59.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.124:33447
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.124
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json with env {}
20:02:59.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.787806  7247 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:02:59.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.794005  7247 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.804610  7247 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.811828  7247 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.812794  7198 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.814059  7247 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.836664  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } attempt: 3
20:02:59.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.841645  7175 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.843243  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.863332  7247 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 1
20:02:59.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.865453  7247 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.874435  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 1
20:02:59.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.876471  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.906837  7249 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:02:59.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.907115  7249 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:02:59.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.907181  7249 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:02:59.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911194  7249 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
20:02:59.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911307  7249 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:02:59.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911339  7249 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
20:02:59.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911365  7249 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
20:02:59.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911391  7249 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
20:02:59.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.911412  7249 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:41709/jwks.json
20:02:59.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.916054  7249 master_runner.cc:387] Master server non-default flags:
20:02:59.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:02:59.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:02:59.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:02:59.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.124:33447
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:41709/jwks.json
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:02:59.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data/info.pb
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.124
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7249
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:02:59.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/logs
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:02:59.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:02:59.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:02:59.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:02:59.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.917670  7249 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:02:59.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.919461  7249 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:02:59.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.925902  7258 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
20:02:59.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.925885  7260 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
20:02:59.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.926641  7249 server_base.cc:1061] running on GCE node
20:02:59.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.925905  7257 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
20:02:59.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.929973  7249 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:02:59.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.931166  7249 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:02:59.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.932368  7249 hybrid_clock.cc:648] HybridClock initialized: now 1783540979932347 us; error 46 us; skew 500 ppm
20:02:59.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.933673  7247 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 2
20:02:59.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.934892  7249 webserver.cc:533] Webserver started at http://127.6.238.124:37499/ using document root <none> and password file <none>
20:02:59.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.935278  7247 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.935621  7249 fs_manager.cc:362] Metadata directory not provided
20:02:59.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.935696  7249 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:02:59.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.935949  7249 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:02:59.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.938037  7249 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data/instance:
20:02:59.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed"
20:02:59.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.938637  7249 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal/instance:
20:02:59.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed"
20:02:59.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.942318  7249 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
20:02:59.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.944849  7266 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:02:59.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.946211  7249 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
20:02:59.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.946359  7249 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal
20:02:59.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed"
20:02:59.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:02:59 on dist-test-slave-vfns"
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.946473  7249 fs_report.cc:389] FS layout report
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data/data
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:02:59.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:02:59.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:02:59.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.951682  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 2
20:02:59.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:02:59.953351  7175 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.6.238.124:33447: Network error: Client connection negotiation failed: client connection to 127.6.238.124:33447: connect: Connection refused (error 111)
20:02:59.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.969668  7249 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:02:59.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.970621  7249 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:02:59.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.970885  7249 kserver.cc:163] Server-wide thread pool size limit: 3276
20:02:59.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.978905  7249 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.124:33447
20:02:59.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.978912  7318 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.124:33447 every 8 connection(s)
20:02:59.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.980135  7249 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/data/info.pb
20:02:59.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.983727  7319 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
20:02:59.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.984023  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7249
20:02:59.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.984114  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/master-2/wal/instance
20:02:59.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.988240  7319 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } has no permanent_uuid. Determining permanent_uuid...
20:02:59.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:02:59.997880  7319 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } has no permanent_uuid. Determining permanent_uuid...
20:03:00.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.003566  7319 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } has no permanent_uuid. Determining permanent_uuid...
20:03:00.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.011220  7319 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: Bootstrap starting.
20:03:00.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.014017  7319 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: Neither blocks nor log segments found. Creating new log.
20:03:00.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.015558  7319 log.cc:826] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: Log is configured to *not* fsync() on all Append() calls
20:03:00.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.017644  7319 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: No bootstrap required, opened a new log
20:03:00.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.021073  7319 raft_consensus.cc:359] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.021351  7319 raft_consensus.cc:385] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:00.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.021389  7319 raft_consensus.cc:740] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bf60a2deb01d40fa8d3614f01e7ea9ed, State: Initialized, Role: FOLLOWER
20:03:00.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.021831  7319 consensus_queue.cc:260] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.022330  7327 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.022480  7327 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.022945  7319 sys_catalog.cc:565] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: configured and running, proceeding with master startup.
20:03:00.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.026660  7247 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 3
20:03:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.028379  7338 catalog_manager.cc:1594] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:03:00.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.028817  7338 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:03:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.028012  7249 master_runner.cc:187] Error getting master registration for 127.6.238.126:41803: OK, instance_id { permanent_uuid: "753095580b85456eb1e079b93e8b275e" instance_seqno: 1783540979590870 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:03:00.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.031116  7249 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:03:00.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.034376  7247 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: Bootstrap starting.
20:03:00.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.036748  7247 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: Neither blocks nor log segments found. Creating new log.
20:03:00.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.037792  7247 log.cc:826] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: Log is configured to *not* fsync() on all Append() calls
20:03:00.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.039580  7247 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: No bootstrap required, opened a new log
20:03:00.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.042285  7247 raft_consensus.cc:359] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.042462  7247 raft_consensus.cc:385] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:00.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.042503  7247 raft_consensus.cc:740] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d82e56b8e9a34149b6b3a7a571a51ce8, State: Initialized, Role: FOLLOWER
20:03:00.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.042976  7247 consensus_queue.cc:260] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.044308  7341 sys_catalog.cc:455] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.044462  7341 sys_catalog.cc:458] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.044636  7247 sys_catalog.cc:565] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: configured and running, proceeding with master startup.
20:03:00.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.050441  7352 catalog_manager.cc:1594] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
20:03:00.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.050977  7352 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
20:03:00.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.048777  7179 master_runner.cc:187] Error getting master registration for 127.6.238.126:41803: OK, instance_id { permanent_uuid: "753095580b85456eb1e079b93e8b275e" instance_seqno: 1783540979590870 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
20:03:00.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.051874  7179 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
20:03:00.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.052512  7175 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } attempt: 3
20:03:00.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.061038  7175 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: Bootstrap starting.
20:03:00.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.061058  7327 raft_consensus.cc:493] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:03:00.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.061275  7327 raft_consensus.cc:515] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.062350  7327 leader_election.cc:290] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 753095580b85456eb1e079b93e8b275e (127.6.238.126:41803), d82e56b8e9a34149b6b3a7a571a51ce8 (127.6.238.125:35035)
20:03:00.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.063081  7221 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" is_pre_election: true
20:03:00.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.063362  7221 raft_consensus.cc:2468] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate bf60a2deb01d40fa8d3614f01e7ea9ed in term 0.
20:03:00.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.064759  7270 leader_election.cc:304] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [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: bf60a2deb01d40fa8d3614f01e7ea9ed, d82e56b8e9a34149b6b3a7a571a51ce8; no voters: 
20:03:00.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.066097  7327 raft_consensus.cc:2804] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Leader pre-election won for term 1
20:03:00.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.066193  7327 raft_consensus.cc:493] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:03:00.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.066238  7327 raft_consensus.cc:3060] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 0 FOLLOWER]: Advancing to term 1
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.066448  7175 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: Neither blocks nor log segments found. Creating new log.
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.067389  7175 log.cc:826] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: Log is configured to *not* fsync() on all Append() calls
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.067806  7327 raft_consensus.cc:515] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.068266  7327 leader_election.cc:290] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [CANDIDATE]: Term 1 election: Requested vote from peers 753095580b85456eb1e079b93e8b275e (127.6.238.126:41803), d82e56b8e9a34149b6b3a7a571a51ce8 (127.6.238.125:35035)
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.068822  7221 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8"
20:03:00.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.068953  7221 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 0 FOLLOWER]: Advancing to term 1
20:03:00.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.070128  7221 raft_consensus.cc:2468] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bf60a2deb01d40fa8d3614f01e7ea9ed in term 1.
20:03:00.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.070619  7270 leader_election.cc:304] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [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: bf60a2deb01d40fa8d3614f01e7ea9ed, d82e56b8e9a34149b6b3a7a571a51ce8; no voters: 
20:03:00.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.070907  7327 raft_consensus.cc:2804] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 1 FOLLOWER]: Leader election won for term 1
20:03:00.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.071362  7327 raft_consensus.cc:697] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [term 1 LEADER]: Becoming Leader. State: Replica: bf60a2deb01d40fa8d3614f01e7ea9ed, State: Running, Role: LEADER
20:03:00.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.072077  7327 consensus_queue.cc:237] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.077208  7327 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: SysCatalogTable state changed. Reason: New leader bf60a2deb01d40fa8d3614f01e7ea9ed. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.078512  7327 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: This master's current role is: LEADER
20:03:00.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.080998  7175 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: No bootstrap required, opened a new log
20:03:00.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.089530  7357 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
20:03:00.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.090987  7175 raft_consensus.cc:359] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.091223  7175 raft_consensus.cc:385] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:00.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.091289  7175 raft_consensus.cc:740] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 753095580b85456eb1e079b93e8b275e, State: Initialized, Role: FOLLOWER
20:03:00.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.092646  7357 catalog_manager.cc:1520] Initializing Kudu cluster ID...
20:03:00.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.095368  7175 consensus_queue.cc:260] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [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: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } }
20:03:00.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.097258  7175 sys_catalog.cc:565] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: configured and running, proceeding with master startup.
20:03:00.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.097288  7149 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "753095580b85456eb1e079b93e8b275e" is_pre_election: true
20:03:00.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.098763  7149 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate bf60a2deb01d40fa8d3614f01e7ea9ed in term 0.
20:03:00.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.097441  7148 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "753095580b85456eb1e079b93e8b275e"
20:03:00.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.098892  7148 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 0 FOLLOWER]: Advancing to term 1
20:03:00.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.100135  7148 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate bf60a2deb01d40fa8d3614f01e7ea9ed in term 1.
20:03:00.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.101260  7359 sys_catalog.cc:455] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.101402  7359 sys_catalog.cc:458] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.101603  7221 raft_consensus.cc:1275] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [term 1 FOLLOWER]: Refusing update from remote peer bf60a2deb01d40fa8d3614f01e7ea9ed: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:00.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.102396  7327 consensus_queue.cc:1048] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [LEADER]: Connected to new peer: Peer: permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:03:00.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.103549  7148 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [term 1 FOLLOWER]: Refusing update from remote peer bf60a2deb01d40fa8d3614f01e7ea9ed: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:00.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.108135  7341 sys_catalog.cc:455] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bf60a2deb01d40fa8d3614f01e7ea9ed. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.108297  7341 sys_catalog.cc:458] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.108423  7327 consensus_queue.cc:1048] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [LEADER]: Connected to new peer: Peer: permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:03:00.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.112629  7359 sys_catalog.cc:455] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: SysCatalogTable state changed. Reason: New leader bf60a2deb01d40fa8d3614f01e7ea9ed. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.112779  7359 sys_catalog.cc:458] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.119589  7355 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.119753  7355 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: This master's current role is: LEADER
20:03:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.119869  7358 mvcc.cc:204] Tried to move back new op lower bound from 7305383854481182720 to 7305383854383140864. Current Snapshot: MvccSnapshot[applied={T|T < 7305383854481182720}]
20:03:00.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.120200  7359 sys_catalog.cc:455] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.120322  7359 sys_catalog.cc:458] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.120947  7362 mvcc.cc:204] Tried to move back new op lower bound from 7305383854481182720 to 7305383854383140864. Current Snapshot: MvccSnapshot[applied={T|T < 7305383854481182720}]
20:03:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.123463  7327 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.123612  7327 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed [sys.catalog]: This master's current role is: LEADER
20:03:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.124922  7341 sys_catalog.cc:455] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "753095580b85456eb1e079b93e8b275e" member_type: VOTER last_known_addr { host: "127.6.238.126" port: 41803 } } peers { permanent_uuid: "d82e56b8e9a34149b6b3a7a571a51ce8" member_type: VOTER last_known_addr { host: "127.6.238.125" port: 35035 } } peers { permanent_uuid: "bf60a2deb01d40fa8d3614f01e7ea9ed" member_type: VOTER last_known_addr { host: "127.6.238.124" port: 33447 } } }
20:03:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.125017  7341 sys_catalog.cc:458] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8 [sys.catalog]: This master's current role is: FOLLOWER
20:03:00.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.126612  7360 mvcc.cc:204] Tried to move back new op lower bound from 7305383854481182720 to 7305383854383140864. Current Snapshot: MvccSnapshot[applied={T|T < 7305383854481182720}]
20:03:00.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.133586  7376 catalog_manager.cc:1295] Loaded cluster ID: 7aeef6a5552744ef95f7abd58f4c2a99
20:03:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.134657  7357 catalog_manager.cc:1383] Generated new cluster ID: 7aeef6a5552744ef95f7abd58f4c2a99
20:03:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.134749  7357 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
20:03:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.134822  7376 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: loading cluster ID for follower catalog manager: success
20:03:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.135360  7376 catalog_manager.cc:1612] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: acquiring CA information for follower catalog manager: Not found: root CA entry not found
20:03:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.135447  7376 catalog_manager.cc:883] Not found: root CA entry not found: failed to prepare follower catalog manager, will retry
20:03:00.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.172323  7357 catalog_manager.cc:1406] Generated new certificate authority record
20:03:00.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.174031  7357 catalog_manager.cc:1540] Loading token signing keys...
20:03:00.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.196432  7357 catalog_manager.cc:6070] T 00000000000000000000000000000000 P bf60a2deb01d40fa8d3614f01e7ea9ed: Generated new TSK 0
20:03:00.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.197706  7357 catalog_manager.cc:1550] Initializing in-progress tserver states...
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.209400  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/logs
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data/info.pb
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.65:0
20:03:00.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.65
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.65
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:00.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.362304  7379 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:00.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.362627  7379 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:00.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.362704  7379 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:00.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.366593  7379 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:00.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.366770  7379 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.6.238.65
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.371173  7379 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:00.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.65:0
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data/info.pb
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.65
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7379
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.65
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/logs
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:03:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.372718  7379 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:00.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.374282  7379 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:00.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.381263  7387 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
20:03:00.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.381263  7385 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
20:03:00.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.381616  7384 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
20:03:00.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.382258  7379 server_base.cc:1061] running on GCE node
20:03:00.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.382715  7379 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:00.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.383424  7379 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:00.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.384657  7379 hybrid_clock.cc:648] HybridClock initialized: now 1783540980384580 us; error 88 us; skew 500 ppm
20:03:00.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.390625  7379 webserver.cc:533] Webserver started at http://127.6.238.65:43363/ using document root <none> and password file <none>
20:03:00.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.391487  7379 fs_manager.cc:362] Metadata directory not provided
20:03:00.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.391592  7379 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:00.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.391861  7379 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:00.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.393677  7379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data/instance:
20:03:00.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5251e458e9ac40bf86389390938b5020"
20:03:00.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.394268  7379 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal/instance:
20:03:00.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5251e458e9ac40bf86389390938b5020"
20:03:00.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.398535  7379 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.004s
20:03:00.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.402010  7393 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.403458  7379 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.403586  7379 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5251e458e9ac40bf86389390938b5020"
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.403715  7379 fs_report.cc:389] FS layout report
20:03:00.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:00.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal
20:03:00.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal
20:03:00.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data/data
20:03:00.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:00.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:00.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:00.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:00.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:00.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.426846  7379 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:00.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.428485  7379 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:00.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.428732  7379 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:00.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.429548  7379 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:00.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.431094  7379 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:00.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.431170  7379 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:00.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.431237  7379 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:00.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.431275  7379 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:00.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.445160  7379 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.65:34647
20:03:00.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.445192  7506 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.65:34647 every 8 connection(s)
20:03:00.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.446565  7379 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/data/info.pb
20:03:00.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.450621  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7379
20:03:00.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.450766  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-0/wal/instance
20:03:00.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.455179  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/logs
20:03:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data/info.pb
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.66:0
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.66
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.66
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:00.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.459965  7509 heartbeater.cc:344] Connected to a master server at 127.6.238.125:35035
20:03:00.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.460026  7507 heartbeater.cc:344] Connected to a master server at 127.6.238.124:33447
20:03:00.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.460239  7507 heartbeater.cc:461] Registering TS with master...
20:03:00.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.460244  7509 heartbeater.cc:461] Registering TS with master...
20:03:00.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.461009  7509 heartbeater.cc:507] Master 127.6.238.125:35035 requested a full tablet report, sending...
20:03:00.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.461010  7507 heartbeater.cc:507] Master 127.6.238.124:33447 requested a full tablet report, sending...
20:03:00.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.461670  7508 heartbeater.cc:344] Connected to a master server at 127.6.238.126:41803
20:03:00.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.461762  7508 heartbeater.cc:461] Registering TS with master...
20:03:00.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.461984  7508 heartbeater.cc:507] Master 127.6.238.126:41803 requested a full tablet report, sending...
20:03:00.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.462983  7283 ts_manager.cc:194] Registered new tserver with Master: 5251e458e9ac40bf86389390938b5020 (127.6.238.65:34647)
20:03:00.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.463006  7207 ts_manager.cc:194] Registered new tserver with Master: 5251e458e9ac40bf86389390938b5020 (127.6.238.65:34647)
20:03:00.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.463306  7139 ts_manager.cc:194] Registered new tserver with Master: 5251e458e9ac40bf86389390938b5020 (127.6.238.65:34647)
20:03:00.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.464449  7283 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.6.238.65:44999
20:03:00.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.573396  7514 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:00.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.573717  7514 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:00.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.573765  7514 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:00.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.578099  7514 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:00.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.578240  7514 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.6.238.66
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.582996  7514 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.66:0
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data/info.pb
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.66
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7514
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.66
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/logs
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:00.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:03:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:03:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:03:00.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.584455  7514 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:00.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.586018  7514 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:00.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.594094  7514 server_base.cc:1061] running on GCE node
20:03:00.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.594041  7520 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
20:03:00.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.594291  7519 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
20:03:00.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.594044  7522 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
20:03:00.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.595556  7514 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:00.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.596184  7514 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:00.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.597458  7514 hybrid_clock.cc:648] HybridClock initialized: now 1783540980597435 us; error 36 us; skew 500 ppm
20:03:00.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.599838  7514 webserver.cc:533] Webserver started at http://127.6.238.66:41919/ using document root <none> and password file <none>
20:03:00.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.600487  7514 fs_manager.cc:362] Metadata directory not provided
20:03:00.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.600603  7514 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:00.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.600867  7514 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:00.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.602600  7514 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data/instance:
20:03:00.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "82582a0d0a004de0bec21d084ab238b5"
20:03:00.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.603147  7514 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal/instance:
20:03:00.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "82582a0d0a004de0bec21d084ab238b5"
20:03:00.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.606982  7514 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
20:03:00.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.609355  7528 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:00.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.610602  7514 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.610752  7514 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "82582a0d0a004de0bec21d084ab238b5"
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.610872  7514 fs_report.cc:389] FS layout report
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal
20:03:00.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data/data
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:00.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:00.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.633678  7514 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:00.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.634548  7514 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:00.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.634793  7514 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:00.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.635514  7514 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:00.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.636875  7514 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:00.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.636973  7514 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:00.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.637039  7514 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:00.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.637065  7514 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:00.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.648394  7514 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.66:37185
20:03:00.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.648458  7641 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.66:37185 every 8 connection(s)
20:03:00.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.649672  7514 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/data/info.pb
20:03:00.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.656141  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7514
20:03:00.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.656288  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-1/wal/instance
20:03:00.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.659147  7097 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/logs
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data/info.pb
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
20:03:00.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.67:0
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.67
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.67
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
20:03:00.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.661789  7643 heartbeater.cc:344] Connected to a master server at 127.6.238.126:41803
20:03:00.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.661800  7644 heartbeater.cc:344] Connected to a master server at 127.6.238.125:35035
20:03:00.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.662093  7644 heartbeater.cc:461] Registering TS with master...
20:03:00.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.662092  7643 heartbeater.cc:461] Registering TS with master...
20:03:00.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.662823  7643 heartbeater.cc:507] Master 127.6.238.126:41803 requested a full tablet report, sending...
20:03:00.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.662824  7644 heartbeater.cc:507] Master 127.6.238.125:35035 requested a full tablet report, sending...
20:03:00.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.664064  7207 ts_manager.cc:194] Registered new tserver with Master: 82582a0d0a004de0bec21d084ab238b5 (127.6.238.66:37185)
20:03:00.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.664096  7139 ts_manager.cc:194] Registered new tserver with Master: 82582a0d0a004de0bec21d084ab238b5 (127.6.238.66:37185)
20:03:00.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.666232  7642 heartbeater.cc:344] Connected to a master server at 127.6.238.124:33447
20:03:00.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.666381  7642 heartbeater.cc:461] Registering TS with master...
20:03:00.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.666694  7642 heartbeater.cc:507] Master 127.6.238.124:33447 requested a full tablet report, sending...
20:03:00.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.667559  7283 ts_manager.cc:194] Registered new tserver with Master: 82582a0d0a004de0bec21d084ab238b5 (127.6.238.66:37185)
20:03:00.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.668311  7283 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.6.238.66:57583
20:03:00.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.781893  7649 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
20:03:00.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.782119  7649 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
20:03:00.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.782163  7649 flags.cc:432] Enabled unsafe flag: --never_fsync=true
20:03:00.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.786744  7649 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
20:03:00.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.786885  7649 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.6.238.67
20:03:00.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.791330  7649 tablet_server_runner.cc:78] Tablet server non-default flags:
20:03:00.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
20:03:00.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.6.238.84:43343
20:03:00.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
20:03:00.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.6.238.67:0
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data/info.pb
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.6.238.67
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.6.238.126:41803,127.6.238.125:35035,127.6.238.124:33447
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7649
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.6.238.67
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/logs
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
20:03:00.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 844bedc15e81bd62879377e001142786f7d931d8
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 19:43:16 UTC on bdcb31816ec0
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 12776
20:03:00.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.792666  7649 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
20:03:00.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.793947  7649 file_cache.cc:504] Constructed file cache file cache with capacity 419430
20:03:00.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.801609  7655 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
20:03:00.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.801703  7658 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
20:03:00.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.801697  7649 server_base.cc:1061] running on GCE node
20:03:00.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:00.801605  7656 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
20:03:00.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.802863  7649 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
20:03:00.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.803611  7649 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
20:03:00.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.804811  7649 hybrid_clock.cc:648] HybridClock initialized: now 1783540980804788 us; error 40 us; skew 500 ppm
20:03:00.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.807227  7649 webserver.cc:533] Webserver started at http://127.6.238.67:45419/ using document root <none> and password file <none>
20:03:00.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.807895  7649 fs_manager.cc:362] Metadata directory not provided
20:03:00.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.807986  7649 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
20:03:00.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.808290  7649 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.810020  7649 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data/instance:
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "19e5064db2664f4c8e2d2ca0687d741e"
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.810585  7649 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal/instance:
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "19e5064db2664f4c8e2d2ca0687d741e"
20:03:00.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.814580  7649 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
20:03:00.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.817422  7664 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
20:03:00.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.818835  7649 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.818938  7649 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data,/tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "19e5064db2664f4c8e2d2ca0687d741e"
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 20:03:00 on dist-test-slave-vfns"
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.819020  7649 fs_report.cc:389] FS layout report
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data/data
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
20:03:00.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
20:03:00.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.850281  7649 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
20:03:00.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.851301  7649 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
20:03:00.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.851523  7649 kserver.cc:163] Server-wide thread pool size limit: 3276
20:03:00.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.852415  7649 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
20:03:00.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.853670  7649 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
20:03:00.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.853735  7649 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
20:03:00.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.853781  7649 ts_tablet_manager.cc:616] Registered 0 tablets
20:03:00.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.853798  7649 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
20:03:00.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.864807  7649 rpc_server.cc:307] RPC server started. Bound to: 127.6.238.67:36109
20:03:00.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.864845  7777 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.6.238.67:36109 every 8 connection(s)
20:03:00.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.866293  7649 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/data/info.pb
20:03:00.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.876297  7097 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu as pid 7649
20:03:00.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.876442  7097 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasksDi6HZ/test-tmp/mini-kudu-cluster10572659426351549345/ts-2/wal/instance
20:03:00.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.880874  7779 heartbeater.cc:344] Connected to a master server at 127.6.238.126:41803
20:03:00.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.881207  7779 heartbeater.cc:461] Registering TS with master...
20:03:00.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.881925  7779 heartbeater.cc:507] Master 127.6.238.126:41803 requested a full tablet report, sending...
20:03:00.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.882486  7778 heartbeater.cc:344] Connected to a master server at 127.6.238.124:33447
20:03:00.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.882575  7778 heartbeater.cc:461] Registering TS with master...
20:03:00.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.882757  7778 heartbeater.cc:507] Master 127.6.238.124:33447 requested a full tablet report, sending...
20:03:00.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.883232  7780 heartbeater.cc:344] Connected to a master server at 127.6.238.125:35035
20:03:00.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.883327  7780 heartbeater.cc:461] Registering TS with master...
20:03:00.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.883524  7780 heartbeater.cc:507] Master 127.6.238.125:35035 requested a full tablet report, sending...
20:03:00.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.883584  7283 ts_manager.cc:194] Registered new tserver with Master: 19e5064db2664f4c8e2d2ca0687d741e (127.6.238.67:36109)
20:03:00.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.884361  7283 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.6.238.67:39285
20:03:00.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.884989  7207 ts_manager.cc:194] Registered new tserver with Master: 19e5064db2664f4c8e2d2ca0687d741e (127.6.238.67:36109)
20:03:00.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.885598  7139 ts_manager.cc:194] Registered new tserver with Master: 19e5064db2664f4c8e2d2ca0687d741e (127.6.238.67:36109)
20:03:00.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:00.902173  7097 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
20:03:00.903 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
20:03:00.904 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

20:03:00.914 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.6.238.126"
      port: 41803
    }
    bound_http_address {
      host: "127.6.238.126"
      port: 44509
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.6.238.125"
      port: 35035
    }
    bound_http_address {
      host: "127.6.238.125"
      port: 39055
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.6.238.124"
      port: 33447
    }
    bound_http_address {
      host: "127.6.238.124"
      port: 37499
    }
  }
}

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

20:03:00.920 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.6.238.65"
      port: 34647
    }
    bound_http_address {
      host: "127.6.238.65"
      port: 43363
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.6.238.66"
      port: 37185
    }
    bound_http_address {
      host: "127.6.238.66"
      port: 41919
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.6.238.67"
      port: 36109
    }
    bound_http_address {
      host: "127.6.238.67"
      port: 45419
    }
  }
}

20:03:00.920 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
20:03:01.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.052940  7352 catalog_manager.cc:1295] Loaded cluster ID: 7aeef6a5552744ef95f7abd58f4c2a99
20:03:01.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.053033  7352 catalog_manager.cc:1588] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: loading cluster ID for follower catalog manager: success
20:03:01.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.056430  7352 catalog_manager.cc:1610] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: acquiring CA information for follower catalog manager: success
20:03:01.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.058341  7352 catalog_manager.cc:1638] T 00000000000000000000000000000000 P d82e56b8e9a34149b6b3a7a571a51ce8: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:03:01.130 [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)
20:03:01.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.138203  7376 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: acquiring CA information for follower catalog manager: success
20:03:01.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.139817  7376 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 753095580b85456eb1e079b93e8b275e: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
20:03:01.192 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
20:03:01.359 [DEBUG - main] (Connection.java:748) [peer master-127.6.238.126:41803(127.6.238.126:41803)] connecting to peer
20:03:01.414 [DEBUG - main] (Connection.java:748) [peer master-127.6.238.124:33447(127.6.238.124:33447)] connecting to peer
20:03:01.416 [DEBUG - main] (Connection.java:748) [peer master-127.6.238.125:35035(127.6.238.125:35035)] connecting to peer
20:03:01.433 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.6.238.124:33447(127.6.238.124:33447)] Successfully connected to peer
20:03:01.433 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.6.238.125:35035(127.6.238.125:35035)] Successfully connected to peer
20:03:01.433 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.6.238.126:41803(127.6.238.126:41803)] Successfully connected to peer
20:03:01.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.466459  7507 heartbeater.cc:499] Master 127.6.238.124:33447 was elected leader, sending a full tablet report...
20:03:01.541 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.6.238.125
20:03:01.542 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.6.238.126
20:03:01.547 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.6.238.124
20:03:01.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.670707  7642 heartbeater.cc:499] Master 127.6.238.124:33447 was elected leader, sending a full tablet report...
20:03:01.774 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0x1248991e, L:/127.0.0.1:47952 - R:/127.6.238.124:33447] using SASL/PLAIN
20:03:01.774 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0xe518898f, L:/127.0.0.1:40008 - R:/127.6.238.126:41803] using SASL/PLAIN
20:03:01.774 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xbeae0718, L:/127.0.0.1:41308 - R:/127.6.238.125:35035] using SASL/PLAIN
20:03:01.813 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
20:03:01.815 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=495), Traces: [0ms] refreshing cache from master, [25ms] Sub RPC ConnectToMaster: sending RPC to server master-127.6.238.126:41803, [91ms] Sub RPC ConnectToMaster: sending RPC to server master-127.6.238.124:33447, [93ms] Sub RPC ConnectToMaster: sending RPC to server master-127.6.238.125:35035, [466ms] Sub RPC ConnectToMaster: received response from server master-127.6.238.124:33447: OK, [466ms] Sub RPC ConnectToMaster: received response from server master-127.6.238.126:41803: OK, [466ms] Sub RPC ConnectToMaster: received response from server master-127.6.238.125:35035: OK, deferred=null) after lookup
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.867638  7283 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:47952:
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783540978852"
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
20:03:01.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
20:03:01.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:01.868937  7283 catalog_manager.cc:7077] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783540978852 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
20:03:01.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.886689  7778 heartbeater.cc:499] Master 127.6.238.124:33447 was elected leader, sending a full tablet report...
20:03:01.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.902697  7576 tablet_service.cc:1511] Processing CreateTablet for tablet edaa9fb57af9408eb8e32c47282da69a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540978852 [id=6236ce405434495182aa863682da9650]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:01.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.907189  7712 tablet_service.cc:1511] Processing CreateTablet for tablet edaa9fb57af9408eb8e32c47282da69a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540978852 [id=6236ce405434495182aa863682da9650]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:01.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.908464  7712 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet edaa9fb57af9408eb8e32c47282da69a. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:01.909 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 6236ce405434495182aa863682da9650
20:03:01.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.913957  7576 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet edaa9fb57af9408eb8e32c47282da69a. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:01.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.916129  7441 tablet_service.cc:1511] Processing CreateTablet for tablet edaa9fb57af9408eb8e32c47282da69a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783540978852 [id=6236ce405434495182aa863682da9650]), partition=RANGE (key) PARTITION UNBOUNDED
20:03:01.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.917325  7441 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet edaa9fb57af9408eb8e32c47282da69a. 1 dirs total, 0 dirs full, 0 dirs failed
20:03:01.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.919360  7810 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Bootstrap starting.
20:03:01.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.921835  7811 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Bootstrap starting.
20:03:01.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.924685  7811 tablet_bootstrap.cc:654] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Neither blocks nor log segments found. Creating new log.
20:03:01.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.928246  7810 tablet_bootstrap.cc:654] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Neither blocks nor log segments found. Creating new log.
20:03:01.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.929618  7810 log.cc:826] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Log is configured to *not* fsync() on all Append() calls
20:03:01.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.930469  7811 log.cc:826] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Log is configured to *not* fsync() on all Append() calls
20:03:01.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.931838  7812 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Bootstrap starting.
20:03:01.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.932094  7810 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: No bootstrap required, opened a new log
20:03:01.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.932343  7810 ts_tablet_manager.cc:1403] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Time spent bootstrapping tablet: real 0.013s	user 0.006s	sys 0.000s
20:03:01.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.934576  7812 tablet_bootstrap.cc:654] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Neither blocks nor log segments found. Creating new log.
20:03:01.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.935284  7812 log.cc:826] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Log is configured to *not* fsync() on all Append() calls
20:03:01.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.935982  7810 raft_consensus.cc:359] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.936245  7810 raft_consensus.cc:385] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:01.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.936305  7810 raft_consensus.cc:740] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 19e5064db2664f4c8e2d2ca0687d741e, State: Initialized, Role: FOLLOWER
20:03:01.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.936882  7810 consensus_queue.cc:260] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [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: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.937120  7812 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: No bootstrap required, opened a new log
20:03:01.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.937150  7811 tablet_bootstrap.cc:492] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: No bootstrap required, opened a new log
20:03:01.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.937392  7811 ts_tablet_manager.cc:1403] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Time spent bootstrapping tablet: real 0.016s	user 0.006s	sys 0.000s
20:03:01.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.937551  7812 ts_tablet_manager.cc:1403] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Time spent bootstrapping tablet: real 0.006s	user 0.005s	sys 0.000s
20:03:01.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.937840  7810 ts_tablet_manager.cc:1434] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Time spent starting tablet: real 0.005s	user 0.005s	sys 0.000s
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.940759  7811 raft_consensus.cc:359] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.940990  7811 raft_consensus.cc:385] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941047  7811 raft_consensus.cc:740] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 82582a0d0a004de0bec21d084ab238b5, State: Initialized, Role: FOLLOWER
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941157  7812 raft_consensus.cc:359] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941367  7812 raft_consensus.cc:385] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941427  7812 raft_consensus.cc:740] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5251e458e9ac40bf86389390938b5020, State: Initialized, Role: FOLLOWER
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941849  7812 consensus_queue.cc:260] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [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: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.941849  7811 consensus_queue.cc:260] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [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: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.944523  7812 ts_tablet_manager.cc:1434] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Time spent starting tablet: real 0.007s	user 0.005s	sys 0.000s
20:03:01.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:01.949226  7510 tablet.cc:2406] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:01.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.950290  7811 ts_tablet_manager.cc:1434] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Time spent starting tablet: real 0.013s	user 0.005s	sys 0.000s
20:03:01.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.977134  7818 raft_consensus.cc:493] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
20:03:01.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.977373  7818 raft_consensus.cc:515] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.978580  7818 leader_election.cc:290] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 82582a0d0a004de0bec21d084ab238b5 (127.6.238.66:37185), 19e5064db2664f4c8e2d2ca0687d741e (127.6.238.67:36109)
20:03:01.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.984766  7732 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "edaa9fb57af9408eb8e32c47282da69a" candidate_uuid: "5251e458e9ac40bf86389390938b5020" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "19e5064db2664f4c8e2d2ca0687d741e" is_pre_election: true
20:03:01.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.984750  7596 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "edaa9fb57af9408eb8e32c47282da69a" candidate_uuid: "5251e458e9ac40bf86389390938b5020" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "82582a0d0a004de0bec21d084ab238b5" is_pre_election: true
20:03:01.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.985064  7596 raft_consensus.cc:2468] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5251e458e9ac40bf86389390938b5020 in term 0.
20:03:01.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.985064  7732 raft_consensus.cc:2468] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5251e458e9ac40bf86389390938b5020 in term 0.
20:03:01.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.985611  7396 leader_election.cc:304] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [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: 5251e458e9ac40bf86389390938b5020, 82582a0d0a004de0bec21d084ab238b5; no voters: 
20:03:01.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.986137  7818 raft_consensus.cc:2804] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Leader pre-election won for term 1
20:03:01.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.986230  7818 raft_consensus.cc:493] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
20:03:01.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.986276  7818 raft_consensus.cc:3060] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 0 FOLLOWER]: Advancing to term 1
20:03:01.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.987157  7818 raft_consensus.cc:515] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.987596  7818 leader_election.cc:290] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [CANDIDATE]: Term 1 election: Requested vote from peers 82582a0d0a004de0bec21d084ab238b5 (127.6.238.66:37185), 19e5064db2664f4c8e2d2ca0687d741e (127.6.238.67:36109)
20:03:01.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.988027  7596 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "edaa9fb57af9408eb8e32c47282da69a" candidate_uuid: "5251e458e9ac40bf86389390938b5020" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "82582a0d0a004de0bec21d084ab238b5"
20:03:01.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.988047  7732 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "edaa9fb57af9408eb8e32c47282da69a" candidate_uuid: "5251e458e9ac40bf86389390938b5020" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "19e5064db2664f4c8e2d2ca0687d741e"
20:03:01.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.988179  7596 raft_consensus.cc:3060] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 0 FOLLOWER]: Advancing to term 1
20:03:01.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.988186  7732 raft_consensus.cc:3060] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 0 FOLLOWER]: Advancing to term 1
20:03:01.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.989215  7596 raft_consensus.cc:2468] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5251e458e9ac40bf86389390938b5020 in term 1.
20:03:01.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.989327  7732 raft_consensus.cc:2468] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5251e458e9ac40bf86389390938b5020 in term 1.
20:03:01.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.989647  7396 leader_election.cc:304] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [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: 19e5064db2664f4c8e2d2ca0687d741e, 5251e458e9ac40bf86389390938b5020; no voters: 
20:03:01.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.989859  7818 raft_consensus.cc:2804] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 1 FOLLOWER]: Leader election won for term 1
20:03:01.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.990096  7818 raft_consensus.cc:697] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [term 1 LEADER]: Becoming Leader. State: Replica: 5251e458e9ac40bf86389390938b5020, State: Running, Role: LEADER
20:03:01.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.990433  7818 consensus_queue.cc:237] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [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: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } }
20:03:01.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:01.994203  7282 catalog_manager.cc:5697] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 reported cstate change: term changed from 0 to 1, leader changed from <none> to 5251e458e9ac40bf86389390938b5020 (127.6.238.65). New cstate: current_term: 1 leader_uuid: "5251e458e9ac40bf86389390938b5020" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "5251e458e9ac40bf86389390938b5020" member_type: VOTER last_known_addr { host: "127.6.238.65" port: 34647 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 } health_report { overall_health: UNKNOWN } } }
20:03:02.023 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet edaa9fb57af9408eb8e32c47282da69a for table 'org.apache.kudu.client.TestHybridTime-1783540978852' with partition [<start>, <end>)
20:03:02.032 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=edaa9fb57af9408eb8e32c47282da69a@[19e5064db2664f4c8e2d2ca0687d741e(127.6.238.67:36109),5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)[L],82582a0d0a004de0bec21d084ab238b5(127.6.238.66:37185)]}]
20:03:02.034 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=21), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.6.238.124:33447, [9ms] Sub RPC GetTableLocations: received response from server master-127.6.238.124:33447: OK, deferred=null) after lookup
20:03:02.049 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)] connecting to peer
20:03:02.053 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)] Successfully connected to peer
20:03:02.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:02.120775  7781 tablet.cc:2406] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:02.130 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x1af1170e, L:/127.0.0.1:50460 - R:/127.6.238.65:34647] using TOKEN/null
20:03:02.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.138479  7596 raft_consensus.cc:1275] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5 [term 1 FOLLOWER]: Refusing update from remote peer 5251e458e9ac40bf86389390938b5020: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:02.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.138480  7732 raft_consensus.cc:1275] T edaa9fb57af9408eb8e32c47282da69a P 19e5064db2664f4c8e2d2ca0687d741e [term 1 FOLLOWER]: Refusing update from remote peer 5251e458e9ac40bf86389390938b5020: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
20:03:02.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.139333  7821 consensus_queue.cc:1048] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [LEADER]: Connected to new peer: Peer: permanent_uuid: "19e5064db2664f4c8e2d2ca0687d741e" member_type: VOTER last_known_addr { host: "127.6.238.67" port: 36109 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:03:02.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.139564  7818 consensus_queue.cc:1048] T edaa9fb57af9408eb8e32c47282da69a P 5251e458e9ac40bf86389390938b5020 [LEADER]: Connected to new peer: Peer: permanent_uuid: "82582a0d0a004de0bec21d084ab238b5" member_type: VOTER last_known_addr { host: "127.6.238.66" port: 37185 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
20:03:02.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.150609  7825 mvcc.cc:204] Tried to move back new op lower bound from 7305383862830510080 to 7305383862235848704. Current Snapshot: MvccSnapshot[applied={T|T < 7305383862830510080}]
20:03:02.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 20:03:02.152901  7645 tablet.cc:2406] T edaa9fb57af9408eb8e32c47282da69a P 82582a0d0a004de0bec21d084ab238b5: Can't schedule compaction. Clean time has not been advanced past its initial value.
20:03:02.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.156201  7826 mvcc.cc:204] Tried to move back new op lower bound from 7305383862830510080 to 7305383862235848704. Current Snapshot: MvccSnapshot[applied={T|T < 7305383862830510080}]
20:03:02.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.156596  7827 mvcc.cc:204] Tried to move back new op lower bound from 7305383862830510080 to 7305383862235848704. Current Snapshot: MvccSnapshot[applied={T|T < 7305383862830510080}]
20:03:02.193 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.208 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.217 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.231 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@71724872(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:02.244 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.244 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@2045813231(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:02.253 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.254 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1894379943(state=PENDING, result=null, callback=<none>, errback=<none>)}
20:03:02.262 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
20:03:02.316 [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-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.324 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305383883310510081) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.329 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305383883310510087) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.334 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305383883310510091) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.339 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305383883310510095) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.345 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305383883310510099) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.351 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305383883310510103) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.358 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305383883310510104) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783540978852, tablet=edaa9fb57af9408eb8e32c47282da69a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
20:03:02.362 [DEBUG - main] (Connection.java:575) [peer master-127.6.238.124:33447(127.6.238.124:33447)] disconnecting while in state READY
20:03:02.365 [DEBUG - main] (Connection.java:575) [peer master-127.6.238.126:41803(127.6.238.126:41803)] disconnecting while in state READY
20:03:02.365 [DEBUG - main] (Connection.java:575) [peer master-127.6.238.125:35035(127.6.238.125:35035)] disconnecting while in state READY
20:03:02.366 [DEBUG - main] (Connection.java:575) [peer 5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)] disconnecting while in state READY
20:03:02.371 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.6.238.126:41803(127.6.238.126:41803)] handling channelInactive
20:03:02.372 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.6.238.126:41803(127.6.238.126:41803)] cleaning up while in state READY due to: connection closed
20:03:02.373 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.6.238.125:35035(127.6.238.125:35035)] handling channelInactive
20:03:02.373 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.6.238.125:35035(127.6.238.125:35035)] cleaning up while in state READY due to: connection closed
20:03:02.374 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.6.238.124:33447(127.6.238.124:33447)] handling channelInactive
20:03:02.374 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.6.238.124:33447(127.6.238.124:33447)] cleaning up while in state READY due to: connection closed
20:03:02.375 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
20:03:02.382 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)] handling channelInactive
20:03:02.383 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 5251e458e9ac40bf86389390938b5020(127.6.238.65:34647)] cleaning up while in state READY due to: connection closed
20:03:02.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.382946  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7379
20:03:02.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.394352  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7514
20:03:02.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.402386  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7649
20:03:02.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.410967  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7108
20:03:02.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.420531  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7179
20:03:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 20:03:02.429941  7097 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasksDi6HZ/build/debug/bin/kudu with pid 7249
20:03:02.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T20:03:02Z chronyd exiting

Time: 3.806

OK (1 test)

