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

18:08:48.332 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:08:48.334 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:08:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.335808 13959 mini_oidc.cc:150] Starting JWKS server
18:08:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.338029 13959 webserver.cc:533] Webserver started at http://127.0.0.1:44417/ using document root <none> and password file <none>
18:08:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.338255 13959 mini_oidc.cc:186] Starting OIDC Discovery server
18:08:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.338603 13959 webserver.cc:533] Webserver started at http://127.0.0.1:39595/ using document root <none> and password file <none>
18:08:48.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:08:48Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:08:48.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:08:48Z Disabled control of system clock
18:08:48.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.358317 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal
18:08:48.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data
18:08:48.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:48.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:48.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:48.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/logs
18:08:48.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data/info.pb
18:08:48.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:48.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:48.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:48.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:48.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:08:48.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:48.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.254:39315
18:08:48.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.254
18:08:48.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json with env {}
18:08:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.484338 13970 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:48.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.484671 13970 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:48.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.484745 13970 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:48.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489174 13970 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:08:48.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489293 13970 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:48.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489326 13970 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:08:48.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489353 13970 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:08:48.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489382 13970 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:08:48.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.489403 13970 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44417/jwks.json
18:08:48.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.494375 13970 master_runner.cc:387] Master server non-default flags:
18:08:48.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/logs
18:08:48.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:48.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data
18:08:48.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal
18:08:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.254:39315
18:08:48.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:48.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json
18:08:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data/info.pb
18:08:48.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.254
18:08:48.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:48.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13970
18:08:48.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:48.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:08:48.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:48.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:48.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:48.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:48.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:48.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.496110 13970 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:48.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.497759 13970 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:48.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.506058 13976 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
18:08:48.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.506035 13977 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
18:08:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.506136 13970 server_base.cc:1061] running on GCE node
18:08:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.506035 13979 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
18:08:48.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.507622 13970 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:48.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.508841 13970 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:48.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.510056 13970 hybrid_clock.cc:648] HybridClock initialized: now 1786471728510031 us; error 45 us; skew 500 ppm
18:08:48.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.512468 13970 webserver.cc:533] Webserver started at http://127.13.161.254:35755/ using document root <none> and password file <none>
18:08:48.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.513254 13970 fs_manager.cc:362] Metadata directory not provided
18:08:48.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.513356 13970 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:48.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.513614 13970 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:48.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.515672 13970 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data/instance:
18:08:48.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bd31ee0a416404084601b41606fba7f"
18:08:48.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.516337 13970 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal/instance:
18:08:48.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bd31ee0a416404084601b41606fba7f"
18:08:48.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.520664 13970 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
18:08:48.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.523417 13985 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:48.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.524573 13970 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
18:08:48.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.524750 13970 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal
18:08:48.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bd31ee0a416404084601b41606fba7f"
18:08:48.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.524880 13970 fs_report.cc:389] FS layout report
18:08:48.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:48.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal
18:08:48.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal
18:08:48.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data/data
18:08:48.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:48.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:48.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:48.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:48.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:48.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:48.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:48.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:48.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:48.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:48.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:48.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.543645 13970 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:48.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.544564 13970 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
18:08:48.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.544798 13970 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:48.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.553337 13970 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.254:39315
18:08:48.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.553355 14046 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.254:39315 every 8 connection(s)
18:08:48.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.554729 13970 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/data/info.pb
18:08:48.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.557930 14047 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:48.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.558218 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 13970
18:08:48.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.558364 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-0/wal/instance
18:08:48.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.560159 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal
18:08:48.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/logs
18:08:48.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data/info.pb
18:08:48.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:48.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:48.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:48.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:08:48.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.253:35853
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.253
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json with env {}
18:08:48.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.563858 14047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.576824 14047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.577656 13988 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.161.253:35853: connect: Connection refused (error 111)
18:08:48.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.578583 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.253:35853: Network error: Client connection negotiation failed: client connection to 127.13.161.253:35853: connect: Connection refused (error 111)
18:08:48.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.627924 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } attempt: 1
18:08:48.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.629886 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.253:35853: Network error: Client connection negotiation failed: client connection to 127.13.161.253:35853: connect: Connection refused (error 111)
18:08:48.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.675709 14049 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:48.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.675984 14049 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:48.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.676035 14049 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:48.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679795 14049 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:08:48.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679877 14049 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:48.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679899 14049 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:08:48.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679919 14049 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:08:48.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679937 14049 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:08:48.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.679952 14049 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44417/jwks.json
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.685832 14049 master_runner.cc:387] Master server non-default flags:
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/logs
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data
18:08:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal
18:08:48.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.253:35853
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:48.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data/info.pb
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.253
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:48.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14049
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:48.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.687362 14049 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:48.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.688850 14049 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:48.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.696069 14058 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
18:08:48.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.696182 14061 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
18:08:48.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.696321 14049 server_base.cc:1061] running on GCE node
18:08:48.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.696069 14059 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
18:08:48.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.698091 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } attempt: 2
18:08:48.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.698257 14049 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:48.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.699482 14049 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:48.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.699992 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.253:35853: Network error: Client connection negotiation failed: client connection to 127.13.161.253:35853: connect: Connection refused (error 111)
18:08:48.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.700722 14049 hybrid_clock.cc:648] HybridClock initialized: now 1786471728700701 us; error 38 us; skew 500 ppm
18:08:48.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.702991 14049 webserver.cc:533] Webserver started at http://127.13.161.253:39351/ using document root <none> and password file <none>
18:08:48.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.703688 14049 fs_manager.cc:362] Metadata directory not provided
18:08:48.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.705085 14049 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:48.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.705400 14049 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:48.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.707620 14049 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data/instance:
18:08:48.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f5200b7511d40429223d2aa0d12d04d"
18:08:48.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.708386 14049 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal/instance:
18:08:48.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f5200b7511d40429223d2aa0d12d04d"
18:08:48.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.712594 14049 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.000s
18:08:48.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.715726 14067 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:48.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.717124 14049 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
18:08:48.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.717303 14049 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal
18:08:48.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f5200b7511d40429223d2aa0d12d04d"
18:08:48.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.717432 14049 fs_report.cc:389] FS layout report
18:08:48.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:48.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data/data
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:48.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:48.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:48.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:48.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.736161 14049 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:48.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.737035 14049 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
18:08:48.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.737264 14049 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:48.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.745100 14122 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.253:35853 every 8 connection(s)
18:08:48.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.745100 14049 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.253:35853
18:08:48.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.746503 14049 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/data/info.pb
18:08:48.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.749586 14123 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:48.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.749997 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 14049
18:08:48.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.750092 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-1/wal/instance
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.750875 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:48.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/logs
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data/info.pb
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:48.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:08:48.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.252:41745
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.252
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json with env {}
18:08:48.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.754654 14123 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.771652 14123 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.778321 14123 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.779348 14072 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.780594 14123 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.791206 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } attempt: 3
18:08:48.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.796360 14047 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.797835 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.829062 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 1
18:08:48.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.830298 14123 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 1
18:08:48.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.831184 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.831957 14123 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.874624 14125 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.875011 14125 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:48.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.875082 14125 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:48.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.878943 14125 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:08:48.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.879047 14125 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:48.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.879079 14125 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:08:48.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.879106 14125 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:08:48.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.879135 14125 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:08:48.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.879155 14125 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44417/jwks.json
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.883790 14125 master_runner.cc:387] Master server non-default flags:
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/logs
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:48.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:48.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.252:41745
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44417/jwks.json
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:48.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data/info.pb
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.252
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14125
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:48.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:48.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.885386 14125 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:48.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.887027 14125 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:48.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.893863 14133 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
18:08:48.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.893967 14125 server_base.cc:1061] running on GCE node
18:08:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.894110 14134 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
18:08:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.893893 14136 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
18:08:48.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.895249 14125 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:48.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.896437 14125 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:48.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.897642 14125 hybrid_clock.cc:648] HybridClock initialized: now 1786471728897586 us; error 80 us; skew 500 ppm
18:08:48.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.899750 14125 webserver.cc:533] Webserver started at http://127.13.161.252:33389/ using document root <none> and password file <none>
18:08:48.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.900194 14123 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 2
18:08:48.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.900797 14125 fs_manager.cc:362] Metadata directory not provided
18:08:48.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.900897 14125 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:48.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.901162 14125 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:48.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.902141 14123 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.903107 14125 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data/instance:
18:08:48.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1d0de57b125f4f5f85b5f66f43d5586b"
18:08:48.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.903615 14125 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal/instance:
18:08:48.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1d0de57b125f4f5f85b5f66f43d5586b"
18:08:48.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.906406 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 2
18:08:48.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.907492 14125 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.001s
18:08:48.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.908128 14047 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.13.161.252:41745: Network error: Client connection negotiation failed: client connection to 127.13.161.252:41745: connect: Connection refused (error 111)
18:08:48.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.910243 14142 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:48.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.911532 14125 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.000s	sys 0.003s
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.911654 14125 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1d0de57b125f4f5f85b5f66f43d5586b"
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:48 on dist-test-slave-8tdl"
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.911739 14125 fs_report.cc:389] FS layout report
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data/data
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:48.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:48.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:48.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.928967 14125 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:48.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.929661 14125 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
18:08:48.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.929818 14125 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:48.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.937938 14125 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.252:41745
18:08:48.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.937943 14204 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.252:41745 every 8 connection(s)
18:08:48.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.939257 14125 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/data/info.pb
18:08:48.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.941313 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 14125
18:08:48.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.941546 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/master-2/wal/instance
18:08:48.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.943346 14205 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:48.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.948218 14205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.958963 14205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.963828 14205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } has no permanent_uuid. Determining permanent_uuid...
18:08:48.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.973176 14205 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: Bootstrap starting.
18:08:48.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.976985 14205 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: Neither blocks nor log segments found. Creating new log.
18:08:48.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.978144 14205 log.cc:826] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: Log is configured to *not* fsync() on all Append() calls
18:08:48.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.981084 14205 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: No bootstrap required, opened a new log
18:08:48.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.984834 14205 raft_consensus.cc:359] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:48.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.985107 14205 raft_consensus.cc:385] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:48.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.985167 14205 raft_consensus.cc:740] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1d0de57b125f4f5f85b5f66f43d5586b, State: Initialized, Role: FOLLOWER
18:08:48.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.985739 14205 consensus_queue.cc:260] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:48.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.987645 14213 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:48.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.987799 14213 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: This master's current role is: FOLLOWER
18:08:48.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.987982 14205 sys_catalog.cc:565] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: configured and running, proceeding with master startup.
18:08:48.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.993366 14123 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 3
18:08:48.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.994269 14224 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:08:48.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:48.994668 14224 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:08:48.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.992797 14125 master_runner.cc:187] Error getting master registration for 127.13.161.254:39315: OK, instance_id { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" instance_seqno: 1786471728551091 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:08:48.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:48.995425 14125 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:08:49.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.001928 14123 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: Bootstrap starting.
18:08:49.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.006105 14123 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: Neither blocks nor log segments found. Creating new log.
18:08:49.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.007395 14123 log.cc:826] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: Log is configured to *not* fsync() on all Append() calls
18:08:49.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.007359 14047 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } attempt: 3
18:08:49.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.012367 14123 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: No bootstrap required, opened a new log
18:08:49.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.016069 14047 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: Bootstrap starting.
18:08:49.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.017262 14123 raft_consensus.cc:359] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.017551 14123 raft_consensus.cc:385] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:49.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.017622 14123 raft_consensus.cc:740] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2f5200b7511d40429223d2aa0d12d04d, State: Initialized, Role: FOLLOWER
18:08:49.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.018194 14123 consensus_queue.cc:260] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.018817 14227 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.019176 14227 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.019266 14047 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: Neither blocks nor log segments found. Creating new log.
18:08:49.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.019747 14123 sys_catalog.cc:565] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: configured and running, proceeding with master startup.
18:08:49.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.020223 14047 log.cc:826] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: Log is configured to *not* fsync() on all Append() calls
18:08:49.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.022397 14047 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: No bootstrap required, opened a new log
18:08:49.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.025287 14240 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:08:49.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.025384 14240 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:08:49.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.024300 14049 master_runner.cc:187] Error getting master registration for 127.13.161.254:39315: OK, instance_id { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" instance_seqno: 1786471728551091 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:08:49.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.026834 14049 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:08:49.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.026866 14047 raft_consensus.cc:359] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.027056 14047 raft_consensus.cc:385] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:49.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.027107 14047 raft_consensus.cc:740] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6bd31ee0a416404084601b41606fba7f, State: Initialized, Role: FOLLOWER
18:08:49.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.027618 14047 consensus_queue.cc:260] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.029131 14047 sys_catalog.cc:565] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: configured and running, proceeding with master startup.
18:08:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.034938 14242 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.035624 14242 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.039502 14254 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:08:49.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.040035 14254 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:08:49.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.040323 13970 master_runner.cc:264] No leader master found from master 6bd31ee0a416404084601b41606fba7f
18:08:49.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.040395 13970 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:08:49.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.046695 13991 tablet.cc:2406] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:08:49.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.073853 14227 raft_consensus.cc:493] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:08:49.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.074056 14227 raft_consensus.cc:515] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.075248 14227 leader_election.cc:290] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 6bd31ee0a416404084601b41606fba7f (127.13.161.254:39315), 1d0de57b125f4f5f85b5f66f43d5586b (127.13.161.252:41745)
18:08:49.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.077807 14018 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "2f5200b7511d40429223d2aa0d12d04d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6bd31ee0a416404084601b41606fba7f" is_pre_election: true
18:08:49.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.078151 14018 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 2f5200b7511d40429223d2aa0d12d04d in term 0.
18:08:49.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.078593 14177 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "2f5200b7511d40429223d2aa0d12d04d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" is_pre_election: true
18:08:49.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.078869 14177 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 2f5200b7511d40429223d2aa0d12d04d in term 0.
18:08:49.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.080251 14072 leader_election.cc:304] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [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: 2f5200b7511d40429223d2aa0d12d04d, 6bd31ee0a416404084601b41606fba7f; no voters: 
18:08:49.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.080823 14227 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Leader pre-election won for term 1
18:08:49.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.080893 14227 raft_consensus.cc:493] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.080938 14227 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 0 FOLLOWER]: Advancing to term 1
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.082214 14227 raft_consensus.cc:515] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.082657 14227 leader_election.cc:290] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [CANDIDATE]: Term 1 election: Requested vote from peers 6bd31ee0a416404084601b41606fba7f (127.13.161.254:39315), 1d0de57b125f4f5f85b5f66f43d5586b (127.13.161.252:41745)
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.083842 14177 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "2f5200b7511d40429223d2aa0d12d04d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1d0de57b125f4f5f85b5f66f43d5586b"
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.083977 14177 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 0 FOLLOWER]: Advancing to term 1
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.085258 14177 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 2f5200b7511d40429223d2aa0d12d04d in term 1.
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.085681 14018 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "2f5200b7511d40429223d2aa0d12d04d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6bd31ee0a416404084601b41606fba7f"
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.085816 14018 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 0 FOLLOWER]: Advancing to term 1
18:08:49.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.087071 14018 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 2f5200b7511d40429223d2aa0d12d04d in term 1.
18:08:49.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.088990 14072 leader_election.cc:304] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [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: 2f5200b7511d40429223d2aa0d12d04d, 6bd31ee0a416404084601b41606fba7f; no voters: 
18:08:49.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.091996 14227 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 1 FOLLOWER]: Leader election won for term 1
18:08:49.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.092310 14227 raft_consensus.cc:697] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [term 1 LEADER]: Becoming Leader. State: Replica: 2f5200b7511d40429223d2aa0d12d04d, State: Running, Role: LEADER
18:08:49.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.092695 14227 consensus_queue.cc:237] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [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: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } }
18:08:49.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.095456 14227 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 2f5200b7511d40429223d2aa0d12d04d. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.095585 14227 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: This master's current role is: LEADER
18:08:49.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.103436 14258 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
18:08:49.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.106236 14258 catalog_manager.cc:1520] Initializing Kudu cluster ID...
18:08:49.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.116719 14177 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [term 1 FOLLOWER]: Refusing update from remote peer 2f5200b7511d40429223d2aa0d12d04d: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:08:49.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.119597 14227 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [LEADER]: Connected to new peer: Peer: permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:08:49.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.125247 14213 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: SysCatalogTable state changed. Reason: New leader 2f5200b7511d40429223d2aa0d12d04d. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.125406 14213 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.127282 14018 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [term 1 FOLLOWER]: Refusing update from remote peer 2f5200b7511d40429223d2aa0d12d04d: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:08:49.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.128425 14256 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [LEADER]: Connected to new peer: Peer: permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:08:49.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.133635 14242 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: SysCatalogTable state changed. Reason: New leader 2f5200b7511d40429223d2aa0d12d04d. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.133780 14242 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.144272 14256 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.144452 14256 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: This master's current role is: LEADER
18:08:49.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.145844 14242 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.145972 14242 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.146836 14259 mvcc.cc:204] Tried to move back new op lower bound from 7317388202448699392 to 7317388202370199552. Current Snapshot: MvccSnapshot[applied={T|T < 7317388202448699392}]
18:08:49.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.147212 14262 mvcc.cc:204] Tried to move back new op lower bound from 7317388202448699392 to 7317388202370199552. Current Snapshot: MvccSnapshot[applied={T|T < 7317388202448699392}]
18:08:49.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.150734 14227 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.150862 14227 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d [sys.catalog]: This master's current role is: LEADER
18:08:49.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.152601 14213 sys_catalog.cc:455] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "2f5200b7511d40429223d2aa0d12d04d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "6bd31ee0a416404084601b41606fba7f" member_type: VOTER last_known_addr { host: "127.13.161.254" port: 39315 } } peers { permanent_uuid: "2f5200b7511d40429223d2aa0d12d04d" member_type: VOTER last_known_addr { host: "127.13.161.253" port: 35853 } } peers { permanent_uuid: "1d0de57b125f4f5f85b5f66f43d5586b" member_type: VOTER last_known_addr { host: "127.13.161.252" port: 41745 } } }
18:08:49.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.152745 14213 sys_catalog.cc:458] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b [sys.catalog]: This master's current role is: FOLLOWER
18:08:49.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.153656 14260 mvcc.cc:204] Tried to move back new op lower bound from 7317388202448699392 to 7317388202370199552. Current Snapshot: MvccSnapshot[applied={T|T < 7317388202448699392}]
18:08:49.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.157747 14258 catalog_manager.cc:1383] Generated new cluster ID: 11f7d104edc74a929985292a3de48361
18:08:49.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.157822 14258 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
18:08:49.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.217275 14258 catalog_manager.cc:1406] Generated new certificate authority record
18:08:49.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.219228 14258 catalog_manager.cc:1540] Loading token signing keys...
18:08:49.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.243646 14258 catalog_manager.cc:6092] T 00000000000000000000000000000000 P 2f5200b7511d40429223d2aa0d12d04d: Generated new TSK 0
18:08:49.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.244956 14258 catalog_manager.cc:1550] Initializing in-progress tserver states...
18:08:49.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.253794 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/logs
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data/info.pb
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.193:0
18:08:49.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.193
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.193
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:08:49.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.376688 14267 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:49.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.376940 14267 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:49.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.376984 14267 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.380759 14267 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:49.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.380973 14267 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.161.193
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.385253 14267 tablet_server_runner.cc:78] Tablet server non-default flags:
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/logs
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.193:0
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data/info.pb
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.193
18:08:49.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14267
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.193
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:49.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.386518 14267 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:49.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.388008 14267 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:49.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.395555 14275 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
18:08:49.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.395573 14272 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
18:08:49.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.396238 14267 server_base.cc:1061] running on GCE node
18:08:49.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.395653 14273 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
18:08:49.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.397159 14267 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:49.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.397763 14267 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:49.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.401140 14267 hybrid_clock.cc:648] HybridClock initialized: now 1786471729401113 us; error 54 us; skew 500 ppm
18:08:49.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.403609 14267 webserver.cc:533] Webserver started at http://127.13.161.193:46649/ using document root <none> and password file <none>
18:08:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.404237 14267 fs_manager.cc:362] Metadata directory not provided
18:08:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.404318 14267 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:49.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.404524 14267 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:49.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.406162 14267 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data/instance:
18:08:49.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5344ae604c554454bcf88440d915439d"
18:08:49.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.406649 14267 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal/instance:
18:08:49.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5344ae604c554454bcf88440d915439d"
18:08:49.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.410743 14267 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
18:08:49.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.413668 14282 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:49.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.415246 14267 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
18:08:49.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.415405 14267 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal
18:08:49.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5344ae604c554454bcf88440d915439d"
18:08:49.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.415537 14267 fs_report.cc:389] FS layout report
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data/data
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:49.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:49.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:49.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.451831 14267 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:49.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.452759 14267 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
18:08:49.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.452997 14267 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:49.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.453696 14267 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:08:49.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.454984 14267 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:08:49.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.455065 14267 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:08:49.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.455132 14267 ts_tablet_manager.cc:616] Registered 0 tablets
18:08:49.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.455155 14267 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:08:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.464910 14267 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.193:37779
18:08:49.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.464987 14404 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.193:37779 every 8 connection(s)
18:08:49.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.466042 14267 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/data/info.pb
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.475775 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 14267
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.475905 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-0/wal/instance
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.476580 14405 heartbeater.cc:344] Connected to a master server at 127.13.161.252:41745
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.476884 14405 heartbeater.cc:461] Registering TS with master...
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.477017 14406 heartbeater.cc:344] Connected to a master server at 127.13.161.254:39315
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.477102 14406 heartbeater.cc:461] Registering TS with master...
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.477578 14406 heartbeater.cc:507] Master 127.13.161.254:39315 requested a full tablet report, sending...
18:08:49.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.477578 14405 heartbeater.cc:507] Master 127.13.161.252:41745 requested a full tablet report, sending...
18:08:49.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.478346 14407 heartbeater.cc:344] Connected to a master server at 127.13.161.253:35853
18:08:49.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.478441 14407 heartbeater.cc:461] Registering TS with master...
18:08:49.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.478657 14407 heartbeater.cc:507] Master 127.13.161.253:35853 requested a full tablet report, sending...
18:08:49.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.479496 14161 ts_manager.cc:194] Registered new tserver with Master: 5344ae604c554454bcf88440d915439d (127.13.161.193:37779)
18:08:49.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.479511 14005 ts_manager.cc:194] Registered new tserver with Master: 5344ae604c554454bcf88440d915439d (127.13.161.193:37779)
18:08:49.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.479823 14084 ts_manager.cc:194] Registered new tserver with Master: 5344ae604c554454bcf88440d915439d (127.13.161.193:37779)
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.481268 14084 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.161.193:42021
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.481472 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/logs
18:08:49.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data/info.pb
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.194:0
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.194
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.194
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:08:49.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.596005 14417 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:49.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.596299 14417 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:49.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.596349 14417 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:49.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.600040 14417 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:49.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.600154 14417 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.161.194
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.604364 14417 tablet_server_runner.cc:78] Tablet server non-default flags:
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/logs
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.194:0
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data/info.pb
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.194
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14417
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.194
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:49.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:49.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.605476 14417 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:49.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.606564 14417 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:49.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.613500 14426 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
18:08:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.613799 14417 server_base.cc:1061] running on GCE node
18:08:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.613502 14422 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
18:08:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.613525 14423 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
18:08:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.614756 14417 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:49.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.615363 14417 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:49.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.616566 14417 hybrid_clock.cc:648] HybridClock initialized: now 1786471729616538 us; error 45 us; skew 500 ppm
18:08:49.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.618839 14417 webserver.cc:533] Webserver started at http://127.13.161.194:36421/ using document root <none> and password file <none>
18:08:49.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.619499 14417 fs_manager.cc:362] Metadata directory not provided
18:08:49.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.619592 14417 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:49.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.619846 14417 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.621641 14417 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data/instance:
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eeff691698cd4badbd6516a3c007050e"
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.622313 14417 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal/instance:
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eeff691698cd4badbd6516a3c007050e"
18:08:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.626132 14417 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
18:08:49.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.628535 14432 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:49.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.629634 14417 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
18:08:49.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.629778 14417 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal
18:08:49.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "eeff691698cd4badbd6516a3c007050e"
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.629887 14417 fs_report.cc:389] FS layout report
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data/data
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:49.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:49.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:49.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.646935 14417 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:49.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.647766 14417 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
18:08:49.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.647989 14417 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:49.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.648818 14417 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:08:49.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.650038 14417 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:08:49.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.650126 14417 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:08:49.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.650188 14417 ts_tablet_manager.cc:616] Registered 0 tablets
18:08:49.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.650213 14417 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:08:49.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.659955 14417 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.194:35837
18:08:49.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.660004 14556 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.194:35837 every 8 connection(s)
18:08:49.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.661099 14417 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/data/info.pb
18:08:49.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.669082 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 14417
18:08:49.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.669220 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-1/wal/instance
18:08:49.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.671557 14559 heartbeater.cc:344] Connected to a master server at 127.13.161.253:35853
18:08:49.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.671851 14559 heartbeater.cc:461] Registering TS with master...
18:08:49.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.671847 14558 heartbeater.cc:344] Connected to a master server at 127.13.161.254:39315
18:08:49.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.671955 14558 heartbeater.cc:461] Registering TS with master...
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.672544 14558 heartbeater.cc:507] Master 127.13.161.254:39315 requested a full tablet report, sending...
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.672544 14559 heartbeater.cc:507] Master 127.13.161.253:35853 requested a full tablet report, sending...
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.672712 13959 external_mini_cluster.cc:1372] Running /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/logs
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data/info.pb
18:08:49.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.195:0
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.195
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.195
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.673799 14086 ts_manager.cc:194] Registered new tserver with Master: eeff691698cd4badbd6516a3c007050e (127.13.161.194:35837)
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.674598 14086 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.161.194:42713
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.675108 14002 ts_manager.cc:194] Registered new tserver with Master: eeff691698cd4badbd6516a3c007050e (127.13.161.194:35837)
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.675592 14557 heartbeater.cc:344] Connected to a master server at 127.13.161.252:41745
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.675686 14557 heartbeater.cc:461] Registering TS with master...
18:08:49.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.675864 14557 heartbeater.cc:507] Master 127.13.161.252:41745 requested a full tablet report, sending...
18:08:49.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.676672 14161 ts_manager.cc:194] Registered new tserver with Master: eeff691698cd4badbd6516a3c007050e (127.13.161.194:35837)
18:08:49.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.804082 14564 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:08:49.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.804337 14564 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:08:49.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.804380 14564 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:08:49.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.807996 14564 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:08:49.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.808130 14564 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.161.195
18:08:49.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.812310 14564 tablet_server_runner.cc:78] Tablet server non-default flags:
18:08:49.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/logs
18:08:49.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:08:49.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.161.212:35657
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.161.195:0
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data/info.pb
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.161.195
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.161.254:39315,127.13.161.253:35853,127.13.161.252:41745
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14564
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.161.195
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:34 UTC on bdcb31816ec0
18:08:49.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17629
18:08:49.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.813597 14564 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:08:49.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.815141 14564 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:08:49.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.822394 14571 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
18:08:49.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.822408 14570 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
18:08:49.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:49.822645 14573 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
18:08:49.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.822721 14564 server_base.cc:1061] running on GCE node
18:08:49.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.823603 14564 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:08:49.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.824391 14564 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:08:49.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.825609 14564 hybrid_clock.cc:648] HybridClock initialized: now 1786471729825579 us; error 46 us; skew 500 ppm
18:08:49.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.827798 14564 webserver.cc:533] Webserver started at http://127.13.161.195:45731/ using document root <none> and password file <none>
18:08:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.828509 14564 fs_manager.cc:362] Metadata directory not provided
18:08:49.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.828615 14564 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:08:49.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.828894 14564 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.830734 14564 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data/instance:
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f074ae9458e84d80b9507a59d3b49633"
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.831398 14564 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal/instance:
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f074ae9458e84d80b9507a59d3b49633"
18:08:49.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.835484 14564 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.001s
18:08:49.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.838084 14579 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:08:49.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.839403 14564 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
18:08:49.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.839566 14564 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data,/tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal
18:08:49.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f074ae9458e84d80b9507a59d3b49633"
18:08:49.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:08:49 on dist-test-slave-8tdl"
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.839702 14564 fs_report.cc:389] FS layout report
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data/data
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:08:49.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:08:49.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.866551 14564 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:08:49.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.867450 14564 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
18:08:49.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.867698 14564 kserver.cc:163] Server-wide thread pool size limit: 3276
18:08:49.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.868477 14564 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:08:49.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.869688 14564 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:08:49.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.869764 14564 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:08:49.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.869827 14564 ts_tablet_manager.cc:616] Registered 0 tablets
18:08:49.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.869848 14564 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:08:49.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.880228 14564 rpc_server.cc:307] RPC server started. Bound to: 127.13.161.195:43537
18:08:49.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.880255 14702 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.13.161.195:43537 every 8 connection(s)
18:08:49.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.881237 14564 server_base.cc:1193] Dumped server information to /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/data/info.pb
18:08:49.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.882054 13959 external_mini_cluster.cc:1434] Started /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu as pid 14564
18:08:49.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.882171 13959 external_mini_cluster.cc:1448] Reading /tmp/dist-test-tasklwRHKw/test-tmp/mini-kudu-cluster2722922113990937946/ts-2/wal/instance
18:08:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892190 14706 heartbeater.cc:344] Connected to a master server at 127.13.161.253:35853
18:08:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892280 14704 heartbeater.cc:344] Connected to a master server at 127.13.161.252:41745
18:08:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892297 14705 heartbeater.cc:344] Connected to a master server at 127.13.161.254:39315
18:08:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892514 14706 heartbeater.cc:461] Registering TS with master...
18:08:49.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892511 14704 heartbeater.cc:461] Registering TS with master...
18:08:49.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.892510 14705 heartbeater.cc:461] Registering TS with master...
18:08:49.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.893231 14705 heartbeater.cc:507] Master 127.13.161.254:39315 requested a full tablet report, sending...
18:08:49.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.893229 14704 heartbeater.cc:507] Master 127.13.161.252:41745 requested a full tablet report, sending...
18:08:49.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.893230 14706 heartbeater.cc:507] Master 127.13.161.253:35853 requested a full tablet report, sending...
18:08:49.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.894584 14161 ts_manager.cc:194] Registered new tserver with Master: f074ae9458e84d80b9507a59d3b49633 (127.13.161.195:43537)
18:08:49.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.894584 14002 ts_manager.cc:194] Registered new tserver with Master: f074ae9458e84d80b9507a59d3b49633 (127.13.161.195:43537)
18:08:49.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.894670 14086 ts_manager.cc:194] Registered new tserver with Master: f074ae9458e84d80b9507a59d3b49633 (127.13.161.195:43537)
18:08:49.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.895390 14086 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.13.161.195:40865
18:08:49.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.905052 13959 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:08:49.906 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:08:49.907 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:08:49.916 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.161.254"
      port: 39315
    }
    bound_http_address {
      host: "127.13.161.254"
      port: 35755
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.161.253"
      port: 35853
    }
    bound_http_address {
      host: "127.13.161.253"
      port: 39351
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.161.252"
      port: 41745
    }
    bound_http_address {
      host: "127.13.161.252"
      port: 33389
    }
  }
}

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

18:08:49.924 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.161.193"
      port: 37779
    }
    bound_http_address {
      host: "127.13.161.193"
      port: 46649
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.161.194"
      port: 35837
    }
    bound_http_address {
      host: "127.13.161.194"
      port: 36421
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.161.195"
      port: 43537
    }
    bound_http_address {
      host: "127.13.161.195"
      port: 45731
    }
  }
}

18:08:49.924 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:08:49.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.996611 14224 catalog_manager.cc:1295] Loaded cluster ID: 11f7d104edc74a929985292a3de48361
18:08:49.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:49.996719 14224 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: loading cluster ID for follower catalog manager: success
18:08:50.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.006208 14224 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: acquiring CA information for follower catalog manager: success
18:08:50.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.008096 14224 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 1d0de57b125f4f5f85b5f66f43d5586b: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:08:50.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.041999 14254 catalog_manager.cc:1295] Loaded cluster ID: 11f7d104edc74a929985292a3de48361
18:08:50.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.042099 14254 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: loading cluster ID for follower catalog manager: success
18:08:50.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.044763 14254 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: acquiring CA information for follower catalog manager: success
18:08:50.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.046499 14254 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 6bd31ee0a416404084601b41606fba7f: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:08:50.115 [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.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	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)
18:08:50.170 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:08:50.347 [DEBUG - main] (Connection.java:748) [peer master-127.13.161.253:35853(127.13.161.253:35853)] connecting to peer
18:08:50.396 [DEBUG - main] (Connection.java:748) [peer master-127.13.161.254:39315(127.13.161.254:39315)] connecting to peer
18:08:50.398 [DEBUG - main] (Connection.java:748) [peer master-127.13.161.252:41745(127.13.161.252:41745)] connecting to peer
18:08:50.417 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.13.161.254:39315(127.13.161.254:39315)] Successfully connected to peer
18:08:50.417 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.13.161.253:35853(127.13.161.253:35853)] Successfully connected to peer
18:08:50.418 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.13.161.252:41745(127.13.161.252:41745)] Successfully connected to peer
18:08:50.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.483148 14407 heartbeater.cc:499] Master 127.13.161.253:35853 was elected leader, sending a full tablet report...
18:08:50.521 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.13.161.254
18:08:50.521 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.13.161.252
18:08:50.521 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.13.161.253
18:08:50.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.677232 14559 heartbeater.cc:499] Master 127.13.161.253:35853 was elected leader, sending a full tablet report...
18:08:50.770 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xb201a914, L:/127.0.0.1:42926 - R:/127.13.161.254:39315] using SASL/PLAIN
18:08:50.770 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x55b3c55b, L:/127.0.0.1:47174 - R:/127.13.161.253:35853] using SASL/PLAIN
18:08:50.772 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xff9a4f0a, L:/127.0.0.1:50810 - R:/127.13.161.252:41745] using SASL/PLAIN
18:08:50.834 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:08:50.836 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=529), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.161.253:35853, [85ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.161.254:39315, [86ms] Sub RPC ConnectToMaster: sending RPC to server master-127.13.161.252:41745, [475ms] Sub RPC ConnectToMaster: received response from server master-127.13.161.252:41745: OK, [475ms] Sub RPC ConnectToMaster: received response from server master-127.13.161.254:39315: OK, [475ms] Sub RPC ConnectToMaster: received response from server master-127.13.161.253:35853: OK, deferred=null) after lookup
18:08:50.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.894822 14086 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:47174:
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786471727809"
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:08:50.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:50.896517 14086 catalog_manager.cc:7099] 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-1786471727809 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:08:50.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.897115 14706 heartbeater.cc:499] Master 127.13.161.253:35853 was elected leader, sending a full tablet report...
18:08:50.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.924705 14336 tablet_service.cc:1511] Processing CreateTablet for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786471727809 [id=29bfbf5f00ac4b93941e28abf9806045]), partition=RANGE (key) PARTITION UNBOUNDED
18:08:50.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.925889 14336 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:50.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.926525 14633 tablet_service.cc:1511] Processing CreateTablet for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786471727809 [id=29bfbf5f00ac4b93941e28abf9806045]), partition=RANGE (key) PARTITION UNBOUNDED
18:08:50.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.927598 14633 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:50.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.935004 14740 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Bootstrap starting.
18:08:50.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.935653 14484 tablet_service.cc:1511] Processing CreateTablet for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786471727809 [id=29bfbf5f00ac4b93941e28abf9806045]), partition=RANGE (key) PARTITION UNBOUNDED
18:08:50.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.936806 14484 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 30e0d5f8b9e3486fb7f3fd9fbd668572. 1 dirs total, 0 dirs full, 0 dirs failed
18:08:50.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.937726 14740 tablet_bootstrap.cc:654] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Neither blocks nor log segments found. Creating new log.
18:08:50.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.938627 14740 log.cc:826] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Log is configured to *not* fsync() on all Append() calls
18:08:50.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.940948 14740 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: No bootstrap required, opened a new log
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.941162 14740 ts_tablet_manager.cc:1403] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.942884 14739 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Bootstrap starting.
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.945272 14739 tablet_bootstrap.cc:654] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Neither blocks nor log segments found. Creating new log.
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.945322 14740 raft_consensus.cc:359] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.945561 14740 raft_consensus.cc:385] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.945608 14740 raft_consensus.cc:740] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f074ae9458e84d80b9507a59d3b49633, State: Initialized, Role: FOLLOWER
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.946102 14740 consensus_queue.cc:260] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [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: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.946203 14739 log.cc:826] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Log is configured to *not* fsync() on all Append() calls
18:08:50.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.947059 14740 ts_tablet_manager.cc:1434] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Time spent starting tablet: real 0.006s	user 0.005s	sys 0.000s
18:08:50.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.949160 14743 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Bootstrap starting.
18:08:50.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.950121 14739 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: No bootstrap required, opened a new log
18:08:50.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.950369 14739 ts_tablet_manager.cc:1403] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Time spent bootstrapping tablet: real 0.008s	user 0.004s	sys 0.000s
18:08:50.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.952266 14743 tablet_bootstrap.cc:654] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Neither blocks nor log segments found. Creating new log.
18:08:50.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.953558 14743 log.cc:826] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Log is configured to *not* fsync() on all Append() calls
18:08:50.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.954499 14739 raft_consensus.cc:359] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.954970 14739 raft_consensus.cc:385] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:50.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.955825 14739 raft_consensus.cc:740] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5344ae604c554454bcf88440d915439d, State: Initialized, Role: FOLLOWER
18:08:50.956 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 29bfbf5f00ac4b93941e28abf9806045
18:08:50.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.956571 14739 consensus_queue.cc:260] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [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: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.957755 14739 ts_tablet_manager.cc:1434] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Time spent starting tablet: real 0.007s	user 0.007s	sys 0.000s
18:08:50.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.961671 14743 tablet_bootstrap.cc:492] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: No bootstrap required, opened a new log
18:08:50.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.961995 14743 ts_tablet_manager.cc:1403] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Time spent bootstrapping tablet: real 0.013s	user 0.005s	sys 0.000s
18:08:50.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.965687 14743 raft_consensus.cc:359] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.965961 14743 raft_consensus.cc:385] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:08:50.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.966027 14743 raft_consensus.cc:740] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: eeff691698cd4badbd6516a3c007050e, State: Initialized, Role: FOLLOWER
18:08:50.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.966562 14743 consensus_queue.cc:260] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [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: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.967662 14743 ts_tablet_manager.cc:1434] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Time spent starting tablet: real 0.006s	user 0.006s	sys 0.000s
18:08:50.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:50.968609 14409 tablet.cc:2406] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:08:50.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.978099 14748 raft_consensus.cc:493] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:08:50.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.978343 14748 raft_consensus.cc:515] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.979776 14748 leader_election.cc:290] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers f074ae9458e84d80b9507a59d3b49633 (127.13.161.195:43537), eeff691698cd4badbd6516a3c007050e (127.13.161.194:35837)
18:08:50.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.984095 14653 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "30e0d5f8b9e3486fb7f3fd9fbd668572" candidate_uuid: "5344ae604c554454bcf88440d915439d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f074ae9458e84d80b9507a59d3b49633" is_pre_election: true
18:08:50.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.984333 14505 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "30e0d5f8b9e3486fb7f3fd9fbd668572" candidate_uuid: "5344ae604c554454bcf88440d915439d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "eeff691698cd4badbd6516a3c007050e" is_pre_election: true
18:08:50.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.984455 14653 raft_consensus.cc:2468] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5344ae604c554454bcf88440d915439d in term 0.
18:08:50.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.984539 14505 raft_consensus.cc:2468] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 5344ae604c554454bcf88440d915439d in term 0.
18:08:50.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.985028 14286 leader_election.cc:304] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [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: 5344ae604c554454bcf88440d915439d, f074ae9458e84d80b9507a59d3b49633; no voters: 
18:08:50.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.985352 14748 raft_consensus.cc:2804] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Leader pre-election won for term 1
18:08:50.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.985435 14748 raft_consensus.cc:493] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:08:50.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.985466 14748 raft_consensus.cc:3060] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 0 FOLLOWER]: Advancing to term 1
18:08:50.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.986375 14748 raft_consensus.cc:515] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.986846 14748 leader_election.cc:290] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [CANDIDATE]: Term 1 election: Requested vote from peers f074ae9458e84d80b9507a59d3b49633 (127.13.161.195:43537), eeff691698cd4badbd6516a3c007050e (127.13.161.194:35837)
18:08:50.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.987273 14505 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "30e0d5f8b9e3486fb7f3fd9fbd668572" candidate_uuid: "5344ae604c554454bcf88440d915439d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "eeff691698cd4badbd6516a3c007050e"
18:08:50.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.987273 14653 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "30e0d5f8b9e3486fb7f3fd9fbd668572" candidate_uuid: "5344ae604c554454bcf88440d915439d" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f074ae9458e84d80b9507a59d3b49633"
18:08:50.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.987416 14653 raft_consensus.cc:3060] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 0 FOLLOWER]: Advancing to term 1
18:08:50.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.987416 14505 raft_consensus.cc:3060] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 0 FOLLOWER]: Advancing to term 1
18:08:50.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.988595 14505 raft_consensus.cc:2468] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5344ae604c554454bcf88440d915439d in term 1.
18:08:50.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.988603 14653 raft_consensus.cc:2468] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 5344ae604c554454bcf88440d915439d in term 1.
18:08:50.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.989034 14286 leader_election.cc:304] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [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: 5344ae604c554454bcf88440d915439d, f074ae9458e84d80b9507a59d3b49633; no voters: 
18:08:50.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.989375 14748 raft_consensus.cc:2804] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 1 FOLLOWER]: Leader election won for term 1
18:08:50.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.989678 14748 raft_consensus.cc:697] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [term 1 LEADER]: Becoming Leader. State: Replica: 5344ae604c554454bcf88440d915439d, State: Running, Role: LEADER
18:08:50.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.990787 14748 consensus_queue.cc:237] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [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: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } }
18:08:50.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:50.995131 14086 catalog_manager.cc:5719] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d reported cstate change: term changed from 0 to 1, leader changed from <none> to 5344ae604c554454bcf88440d915439d (127.13.161.193). New cstate: current_term: 1 leader_uuid: "5344ae604c554454bcf88440d915439d" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "5344ae604c554454bcf88440d915439d" member_type: VOTER last_known_addr { host: "127.13.161.193" port: 37779 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 } health_report { overall_health: UNKNOWN } } }
18:08:51.043 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 30e0d5f8b9e3486fb7f3fd9fbd668572 for table 'org.apache.kudu.client.TestHybridTime-1786471727809' with partition [<start>, <end>)
18:08:51.049 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572@[5344ae604c554454bcf88440d915439d(127.13.161.193:37779)[L],eeff691698cd4badbd6516a3c007050e(127.13.161.194:35837),f074ae9458e84d80b9507a59d3b49633(127.13.161.195:43537)]}]
18:08:51.050 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.13.161.253:35853, [8ms] Sub RPC GetTableLocations: received response from server master-127.13.161.253:35853: OK, deferred=null) after lookup
18:08:51.063 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 5344ae604c554454bcf88440d915439d(127.13.161.193:37779)] connecting to peer
18:08:51.066 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 5344ae604c554454bcf88440d915439d(127.13.161.193:37779)] Successfully connected to peer
18:08:51.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:51.135260 14707 tablet.cc:2406] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:08:51.150 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x82216a6d, L:/127.0.0.1:45450 - R:/127.13.161.193:37779] using TOKEN/null
18:08:51.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.159255 14653 raft_consensus.cc:1275] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P f074ae9458e84d80b9507a59d3b49633 [term 1 FOLLOWER]: Refusing update from remote peer 5344ae604c554454bcf88440d915439d: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:08:51.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.159255 14505 raft_consensus.cc:1275] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e [term 1 FOLLOWER]: Refusing update from remote peer 5344ae604c554454bcf88440d915439d: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:08:51.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.160137 14752 consensus_queue.cc:1048] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [LEADER]: Connected to new peer: Peer: permanent_uuid: "eeff691698cd4badbd6516a3c007050e" member_type: VOTER last_known_addr { host: "127.13.161.194" port: 35837 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:08:51.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.160993 14752 consensus_queue.cc:1048] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P 5344ae604c554454bcf88440d915439d [LEADER]: Connected to new peer: Peer: permanent_uuid: "f074ae9458e84d80b9507a59d3b49633" member_type: VOTER last_known_addr { host: "127.13.161.195" port: 43537 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:08:51.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:08:51.164207 14560 tablet.cc:2406] T 30e0d5f8b9e3486fb7f3fd9fbd668572 P eeff691698cd4badbd6516a3c007050e: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:08:51.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.183499 14760 mvcc.cc:204] Tried to move back new op lower bound from 7317388210819129344 to 7317388210143862784. Current Snapshot: MvccSnapshot[applied={T|T < 7317388210819129344}]
18:08:51.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.184089 14757 mvcc.cc:204] Tried to move back new op lower bound from 7317388210819129344 to 7317388210143862784. Current Snapshot: MvccSnapshot[applied={T|T < 7317388210819129344}]
18:08:51.219 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.233 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.242 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.248 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@148653913(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:08:51.260 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.261 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1653832803(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:08:51.269 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.270 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1856439236(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:08:51.281 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:08:51.336 [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-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.345 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317388231299129345) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.351 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317388231299129351) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.356 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317388231299129355) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.361 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317388231299129359) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.371 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317388231299129363) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.380 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317388231299129367) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.385 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317388231299129368) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786471727809, tablet=30e0d5f8b9e3486fb7f3fd9fbd668572, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:08:51.390 [DEBUG - main] (Connection.java:575) [peer master-127.13.161.252:41745(127.13.161.252:41745)] disconnecting while in state READY
18:08:51.403 [DEBUG - main] (Connection.java:575) [peer master-127.13.161.253:35853(127.13.161.253:35853)] disconnecting while in state READY
18:08:51.403 [DEBUG - main] (Connection.java:575) [peer 5344ae604c554454bcf88440d915439d(127.13.161.193:37779)] disconnecting while in state READY
18:08:51.403 [DEBUG - main] (Connection.java:575) [peer master-127.13.161.254:39315(127.13.161.254:39315)] disconnecting while in state READY
18:08:51.405 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.13.161.252:41745(127.13.161.252:41745)] handling channelInactive
18:08:51.405 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.13.161.252:41745(127.13.161.252:41745)] cleaning up while in state READY due to: connection closed
18:08:51.407 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.13.161.253:35853(127.13.161.253:35853)] handling channelInactive
18:08:51.407 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.13.161.253:35853(127.13.161.253:35853)] cleaning up while in state READY due to: connection closed
18:08:51.404 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.13.161.254:39315(127.13.161.254:39315)] handling channelInactive
18:08:51.408 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.13.161.254:39315(127.13.161.254:39315)] cleaning up while in state READY due to: connection closed
18:08:51.420 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:08:51.435 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 5344ae604c554454bcf88440d915439d(127.13.161.193:37779)] handling channelInactive
18:08:51.435 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 5344ae604c554454bcf88440d915439d(127.13.161.193:37779)] cleaning up while in state READY due to: connection closed
18:08:51.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.437016 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 14267
18:08:51.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.453866 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 14417
18:08:51.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.466807 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 14564
18:08:51.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.479844 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 13970
18:08:51.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.491927 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 14049
18:08:51.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:08:51.503733 13959 external_mini_cluster.cc:1664] Killing /tmp/dist-test-tasklwRHKw/build/debug/bin/kudu with pid 14125
18:08:51.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:08:51Z chronyd exiting

Time: 3.651

OK (1 test)

