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

14:26:19.527 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:26:19.529 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:26:19.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.530088 13162 mini_oidc.cc:150] Starting JWKS server
14:26:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.530885 13162 webserver.cc:533] Webserver started at http://127.0.0.1:39925/ using document root <none> and password file <none>
14:26:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.530982 13162 mini_oidc.cc:186] Starting OIDC Discovery server
14:26:19.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.531173 13162 webserver.cc:533] Webserver started at http://127.0.0.1:46339/ using document root <none> and password file <none>
14:26:19.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:26:19Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:26:19.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:26:19Z Disabled control of system clock
14:26:19.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.546974 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal
14:26:19.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data
14:26:19.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:19.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:19.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:19.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/logs
14:26:19.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data/info.pb
14:26:19.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:19.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:19.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:19.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:19.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:26:19.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:19.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.190:45467
14:26:19.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.190
14:26:19.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json with env {}
14:26:19.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.646683 13173 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:19.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.646862 13173 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:19.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.646883 13173 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:19.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648672 13173 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:26:19.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648725 13173 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:19.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648738 13173 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:26:19.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648751 13173 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:26:19.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648762 13173 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:26:19.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.648773 13173 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39925/jwks.json
14:26:19.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.650600 13173 master_runner.cc:387] Master server non-default flags:
14:26:19.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.190:45467
14:26:19.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:19.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data/info.pb
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.190
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:19.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13173
14:26:19.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:19.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/logs
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:19.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:26:19.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:19.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:19.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:19.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:19.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:19.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.650802 13173 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:19.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.651046 13173 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:19.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.653957 13179 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.654147 13178 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.655799 13181 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.659029 13173 server_base.cc:1061] running on GCE node
14:26:19.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.659256 13173 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:19.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.659495 13173 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:19.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.660646 13173 hybrid_clock.cc:648] HybridClock initialized: now 1779114379660622 us; error 35 us; skew 500 ppm
14:26:19.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.661618 13173 webserver.cc:533] Webserver started at http://127.12.218.190:35629/ using document root <none> and password file <none>
14:26:19.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.661808 13173 fs_manager.cc:362] Metadata directory not provided
14:26:19.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.661859 13173 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:19.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.661950 13173 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:19.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.662922 13173 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data/instance:
14:26:19.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "94848f41b5f94624b86e2b7551abdba2"
14:26:19.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.663283 13173 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal/instance:
14:26:19.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "94848f41b5f94624b86e2b7551abdba2"
14:26:19.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.664585 13173 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
14:26:19.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.665369 13187 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:19.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.665565 13173 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:26:19.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.665628 13173 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal
14:26:19.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "94848f41b5f94624b86e2b7551abdba2"
14:26:19.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.665688 13173 fs_report.cc:389] FS layout report
14:26:19.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:19.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal
14:26:19.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal
14:26:19.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data/data
14:26:19.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:19.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:19.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:19.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:19.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.682770 13173 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:19.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.683164 13173 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:19.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.683269 13173 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:19.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.687037 13173 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.190:45467
14:26:19.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.687148 13240 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.190:45467 every 8 connection(s)
14:26:19.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.687402 13173 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/data/info.pb
14:26:19.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.687928 13241 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:26:19.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.688938 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13173
14:26:19.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.689013 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-0/wal/instance
14:26:19.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.689431 13241 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.689839 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal
14:26:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data
14:26:19.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:19.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:19.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:19.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/logs
14:26:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data/info.pb
14:26:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:19.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:26:19.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:19.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.189:36713
14:26:19.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.189
14:26:19.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json with env {}
14:26:19.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.696089 13241 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.696548 13191 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.12.218.189:36713: connect: Connection refused (error 111)
14:26:19.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.699400 13241 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.189:36713: Network error: Client connection negotiation failed: client connection to 127.12.218.189:36713: connect: Connection refused (error 111)
14:26:19.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.748620 13241 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } attempt: 1
14:26:19.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.749780 13241 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.189:36713: Network error: Client connection negotiation failed: client connection to 127.12.218.189:36713: connect: Connection refused (error 111)
14:26:19.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.772308 13244 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:19.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.772492 13244 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:19.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.772518 13244 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:19.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774257 13244 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:26:19.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774304 13244 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:19.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774319 13244 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:26:19.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774333 13244 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:26:19.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774346 13244 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:26:19.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.774358 13244 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39925/jwks.json
14:26:19.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.776630 13244 master_runner.cc:387] Master server non-default flags:
14:26:19.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.189:36713
14:26:19.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data/info.pb
14:26:19.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.189
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13244
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:19.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/logs
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:19.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:26:19.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:19.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.776916 13244 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:19.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.777161 13244 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.779784 13252 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.779798 13251 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.780798 13244 server_base.cc:1061] running on GCE node
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.780844 13254 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.781069 13244 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:19.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.781352 13244 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:19.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.782523 13244 hybrid_clock.cc:648] HybridClock initialized: now 1779114379782502 us; error 31 us; skew 500 ppm
14:26:19.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.784058 13244 webserver.cc:533] Webserver started at http://127.12.218.189:34211/ using document root <none> and password file <none>
14:26:19.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.784264 13244 fs_manager.cc:362] Metadata directory not provided
14:26:19.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.784314 13244 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.784407 13244 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.785509 13244 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data/instance:
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "97bd4ffb1f3b4a1c830152ff75bb1432"
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.785931 13244 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal/instance:
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "97bd4ffb1f3b4a1c830152ff75bb1432"
14:26:19.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.787601 13244 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
14:26:19.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.791821 13260 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:19.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.792462 13244 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.792543 13244 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "97bd4ffb1f3b4a1c830152ff75bb1432"
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.792619 13244 fs_report.cc:389] FS layout report
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:19.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data/data
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:19.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:19.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:19.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:19.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:19.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:19.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:19.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:19.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.804194 13244 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.804579 13244 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:19.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.804709 13244 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:19.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.809211 13244 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.189:36713
14:26:19.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.809249 13312 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.189:36713 every 8 connection(s)
14:26:19.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.809659 13244 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/data/info.pb
14:26:19.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.810340 13313 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:26:19.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.811704 13313 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.816520 13313 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.817492 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13244
14:26:19.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.817550 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-1/wal/instance
14:26:19.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.817911 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:19.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/logs
14:26:19.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data/info.pb
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:19.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.188:39451
14:26:19.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.188
14:26:19.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json with env {}
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.817960 13241 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } attempt: 2
14:26:19.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.821643 13313 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.822019 13262 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.822638 13313 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.188:39451: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.825600 13241 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.826270 13241 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.188:39451: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.869441 13241 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } attempt: 1
14:26:19.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.870342 13241 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.188:39451: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.871846 13313 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } attempt: 1
14:26:19.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.872596 13313 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.188:39451: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.903573 13318 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:19.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.903769 13318 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:19.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.903791 13318 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:19.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905354 13318 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:26:19.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905408 13318 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:19.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905422 13318 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:26:19.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905434 13318 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:26:19.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905447 13318 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:26:19.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.905458 13318 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39925/jwks.json
14:26:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.907373 13318 master_runner.cc:387] Master server non-default flags:
14:26:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:19.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:19.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.188:39451
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39925/jwks.json
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:19.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data/info.pb
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.188
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13318
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:19.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:19.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:19.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/logs
14:26:19.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:19.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:19.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:19.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.907617 13318 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.907802 13318 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.910228 13327 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.910287 13324 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.910478 13325 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:19.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.911558 13318 server_base.cc:1061] running on GCE node
14:26:19.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.911820 13318 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:19.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.912156 13318 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:19.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.913331 13318 hybrid_clock.cc:648] HybridClock initialized: now 1779114379913295 us; error 47 us; skew 500 ppm
14:26:19.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.914769 13318 webserver.cc:533] Webserver started at http://127.12.218.188:39849/ using document root <none> and password file <none>
14:26:19.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.915007 13318 fs_manager.cc:362] Metadata directory not provided
14:26:19.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.915102 13318 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:19.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.915222 13318 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:19.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.916244 13318 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data/instance:
14:26:19.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a"
14:26:19.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.916646 13318 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal/instance:
14:26:19.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a"
14:26:19.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.917538 13241 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } attempt: 2
14:26:19.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.918215 13241 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.12.218.188:39451: Network error: Client connection negotiation failed: client connection to 127.12.218.188:39451: connect: Connection refused (error 111)
14:26:19.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.918843 13318 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.003s	sys 0.000s
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.919778 13333 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.920006 13318 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.920069 13318 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a"
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:19 on dist-test-slave-78q2"
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.920133 13318 fs_report.cc:389] FS layout report
14:26:19.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data/data
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:19.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:19.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:19.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:19.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:19.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.935273 13318 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:19.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.935724 13318 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:19.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.935858 13318 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:19.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.940378 13318 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.188:39451
14:26:19.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.940764 13313 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } attempt: 2
14:26:19.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.940428 13386 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.188:39451 every 8 connection(s)
14:26:19.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.941597 13318 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/data/info.pb
14:26:19.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.942281 13388 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:26:19.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.943193 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13318
14:26:19.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.943265 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/master-2/wal/instance
14:26:19.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.944420 13388 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.948896 13313 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: Bootstrap starting.
14:26:19.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.949731 13313 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: Neither blocks nor log segments found. Creating new log.
14:26:19.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.950006 13313 log.cc:826] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: Log is configured to *not* fsync() on all Append() calls
14:26:19.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.950299 13388 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.950693 13313 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: No bootstrap required, opened a new log
14:26:19.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.952907 13313 raft_consensus.cc:359] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:19.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.953047 13313 raft_consensus.cc:385] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:26:19.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.953080 13313 raft_consensus.cc:740] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 97bd4ffb1f3b4a1c830152ff75bb1432, State: Initialized, Role: FOLLOWER
14:26:19.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.953197 13313 consensus_queue.cc:260] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:19.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.953502 13313 sys_catalog.cc:565] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: configured and running, proceeding with master startup.
14:26:19.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.955622 13406 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:26:19.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.955693 13406 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:26:19.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.955960 13395 sys_catalog.cc:455] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:19.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.956072 13395 sys_catalog.cc:458] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: This master's current role is: FOLLOWER
14:26:19.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.955717 13244 master_runner.cc:187] Error getting master registration for 127.12.218.190:45467: OK, instance_id { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" instance_seqno: 1779114379686103 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:26:19.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.957480 13244 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:26:19.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.957897 13388 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } has no permanent_uuid. Determining permanent_uuid...
14:26:19.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.961655 13388 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: Bootstrap starting.
14:26:19.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.962329 13388 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: Neither blocks nor log segments found. Creating new log.
14:26:19.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.962654 13388 log.cc:826] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: Log is configured to *not* fsync() on all Append() calls
14:26:19.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.963399 13388 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: No bootstrap required, opened a new log
14:26:19.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965318 13388 raft_consensus.cc:359] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:19.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965446 13388 raft_consensus.cc:385] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:26:19.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965481 13388 raft_consensus.cc:740] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c7a8e2f3e19e4a948f5e88b86861dd2a, State: Initialized, Role: FOLLOWER
14:26:19.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965579 13388 consensus_queue.cc:260] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:19.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965894 13388 sys_catalog.cc:565] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: configured and running, proceeding with master startup.
14:26:19.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965858 13409 sys_catalog.cc:455] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:19.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.965947 13409 sys_catalog.cc:458] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: This master's current role is: FOLLOWER
14:26:19.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.967909 13420 catalog_manager.cc:1594] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:26:19.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:19.967954 13420 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:26:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.968029 13318 master_runner.cc:187] Error getting master registration for 127.12.218.190:45467: OK, instance_id { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" instance_seqno: 1779114379686103 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
14:26:19.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:19.969616 13318 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:26:20.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.025370 13241 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } attempt: 3
14:26:20.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.030592 13241 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: Bootstrap starting.
14:26:20.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.031416 13241 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: Neither blocks nor log segments found. Creating new log.
14:26:20.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.031665 13241 log.cc:826] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: Log is configured to *not* fsync() on all Append() calls
14:26:20.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.032409 13241 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: No bootstrap required, opened a new log
14:26:20.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.034310 13241 raft_consensus.cc:359] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:20.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.034453 13241 raft_consensus.cc:385] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:26:20.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.034485 13241 raft_consensus.cc:740] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 94848f41b5f94624b86e2b7551abdba2, State: Initialized, Role: FOLLOWER
14:26:20.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.034585 13241 consensus_queue.cc:260] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:20.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.034891 13241 sys_catalog.cc:565] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: configured and running, proceeding with master startup.
14:26:20.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.035959 13423 sys_catalog.cc:455] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.036329 13423 sys_catalog.cc:458] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: This master's current role is: FOLLOWER
14:26:20.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.039243 13173 master_runner.cc:264] No leader master found from master 94848f41b5f94624b86e2b7551abdba2
14:26:20.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.039294 13173 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
14:26:20.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.039871 13434 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:26:20.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.040211 13434 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:26:20.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.055377 13266 tablet.cc:2404] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:26:20.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.134581 13395 raft_consensus.cc:493] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:26:20.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.134720 13395 raft_consensus.cc:515] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:20.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.134948 13395 leader_election.cc:290] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 94848f41b5f94624b86e2b7551abdba2 (127.12.218.190:45467), c7a8e2f3e19e4a948f5e88b86861dd2a (127.12.218.188:39451)
14:26:20.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.135597 13215 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "94848f41b5f94624b86e2b7551abdba2" is_pre_election: true
14:26:20.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.135747 13215 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 97bd4ffb1f3b4a1c830152ff75bb1432 in term 0.
14:26:20.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.136124 13361 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" is_pre_election: true
14:26:20.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.136240 13361 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 97bd4ffb1f3b4a1c830152ff75bb1432 in term 0.
14:26:20.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.137594 13264 leader_election.cc:304] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [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: 94848f41b5f94624b86e2b7551abdba2, 97bd4ffb1f3b4a1c830152ff75bb1432; no voters: 
14:26:20.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.137826 13395 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:26:20.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.137866 13395 raft_consensus.cc:493] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:26:20.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.137888 13395 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 0 FOLLOWER]: Advancing to term 1
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.138650 13395 raft_consensus.cc:515] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.138793 13395 leader_election.cc:290] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [CANDIDATE]: Term 1 election: Requested vote from peers 94848f41b5f94624b86e2b7551abdba2 (127.12.218.190:45467), c7a8e2f3e19e4a948f5e88b86861dd2a (127.12.218.188:39451)
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.138998 13361 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a"
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.139102 13361 raft_consensus.cc:3060] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 0 FOLLOWER]: Advancing to term 1
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.139971 13361 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 97bd4ffb1f3b4a1c830152ff75bb1432 in term 1.
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.140147 13262 leader_election.cc:304] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [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: 97bd4ffb1f3b4a1c830152ff75bb1432, c7a8e2f3e19e4a948f5e88b86861dd2a; no voters: 
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.140379 13215 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "94848f41b5f94624b86e2b7551abdba2"
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.140455 13215 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 0 FOLLOWER]: Advancing to term 1
14:26:20.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.141347 13215 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 97bd4ffb1f3b4a1c830152ff75bb1432 in term 1.
14:26:20.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.144579 13395 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 1 FOLLOWER]: Leader election won for term 1
14:26:20.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.144793 13395 raft_consensus.cc:697] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [term 1 LEADER]: Becoming Leader. State: Replica: 97bd4ffb1f3b4a1c830152ff75bb1432, State: Running, Role: LEADER
14:26:20.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.144886 13395 consensus_queue.cc:237] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [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: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } }
14:26:20.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.145236 13395 sys_catalog.cc:455] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 97bd4ffb1f3b4a1c830152ff75bb1432. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.145303 13395 sys_catalog.cc:458] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: This master's current role is: LEADER
14:26:20.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.146533 13438 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:26:20.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.146934 13438 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:26:20.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.148594 13361 raft_consensus.cc:1275] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [term 1 FOLLOWER]: Refusing update from remote peer 97bd4ffb1f3b4a1c830152ff75bb1432: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:26:20.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.148597 13215 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [term 1 FOLLOWER]: Refusing update from remote peer 97bd4ffb1f3b4a1c830152ff75bb1432: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
14:26:20.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.148897 13436 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [LEADER]: Connected to new peer: Peer: permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:26:20.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.150210 13436 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [LEADER]: Connected to new peer: Peer: permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:26:20.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.151521 13409 sys_catalog.cc:455] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: SysCatalogTable state changed. Reason: New leader 97bd4ffb1f3b4a1c830152ff75bb1432. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.151623 13409 sys_catalog.cc:458] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: This master's current role is: FOLLOWER
14:26:20.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.152087 13423 sys_catalog.cc:455] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 97bd4ffb1f3b4a1c830152ff75bb1432. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.152177 13423 sys_catalog.cc:458] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: This master's current role is: FOLLOWER
14:26:20.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154093 13395 sys_catalog.cc:455] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154176 13395 sys_catalog.cc:458] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: This master's current role is: LEADER
14:26:20.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154160 13409 sys_catalog.cc:455] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154247 13409 sys_catalog.cc:458] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a [sys.catalog]: This master's current role is: FOLLOWER
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154431 13439 mvcc.cc:204] Tried to move back new op lower bound from 7287252501086224384 to 7287252501073928192. Current Snapshot: MvccSnapshot[applied={T|T < 7287252501086224384}]
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154712 13436 sys_catalog.cc:455] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.154785 13436 sys_catalog.cc:458] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432 [sys.catalog]: This master's current role is: LEADER
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.155397 13423 sys_catalog.cc:455] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "94848f41b5f94624b86e2b7551abdba2" member_type: VOTER last_known_addr { host: "127.12.218.190" port: 45467 } } peers { permanent_uuid: "97bd4ffb1f3b4a1c830152ff75bb1432" member_type: VOTER last_known_addr { host: "127.12.218.189" port: 36713 } } peers { permanent_uuid: "c7a8e2f3e19e4a948f5e88b86861dd2a" member_type: VOTER last_known_addr { host: "127.12.218.188" port: 39451 } } }
14:26:20.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.155476 13423 sys_catalog.cc:458] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2 [sys.catalog]: This master's current role is: FOLLOWER
14:26:20.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.155587 13442 mvcc.cc:204] Tried to move back new op lower bound from 7287252501086224384 to 7287252501073928192. Current Snapshot: MvccSnapshot[applied={T|T < 7287252501086224384}]
14:26:20.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.156545 13438 catalog_manager.cc:1383] Generated new cluster ID: bc1bae341b624942b05f0fac28ad1cb4
14:26:20.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.156859 13438 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:26:20.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.156980 13440 mvcc.cc:204] Tried to move back new op lower bound from 7287252501086224384 to 7287252501073928192. Current Snapshot: MvccSnapshot[applied={T|T < 7287252501086224384}]
14:26:20.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.177709 13438 catalog_manager.cc:1406] Generated new certificate authority record
14:26:20.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.178861 13438 catalog_manager.cc:1540] Loading token signing keys...
14:26:20.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.187361 13438 catalog_manager.cc:6070] T 00000000000000000000000000000000 P 97bd4ffb1f3b4a1c830152ff75bb1432: Generated new TSK 0
14:26:20.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.187731 13438 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.202836 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:20.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/logs
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data/info.pb
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.129:0
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.129
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.129
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:26:20.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.291720 13448 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:20.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.291950 13448 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:20.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.291981 13448 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:20.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.293816 13448 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:20.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.293936 13448 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.218.129
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.295790 13448 tablet_server_runner.cc:78] Tablet server non-default flags:
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.129:0
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:20.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data/info.pb
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.129
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13448
14:26:20.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.129
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/logs
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:20.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:20.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.296101 13448 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.296406 13448 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.299523 13455 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.299528 13454 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.299820 13457 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.300592 13448 server_base.cc:1061] running on GCE node
14:26:20.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.300766 13448 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:20.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.301004 13448 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:20.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.302191 13448 hybrid_clock.cc:648] HybridClock initialized: now 1779114380302152 us; error 51 us; skew 500 ppm
14:26:20.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.303558 13448 webserver.cc:533] Webserver started at http://127.12.218.129:36981/ using document root <none> and password file <none>
14:26:20.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.303782 13448 fs_manager.cc:362] Metadata directory not provided
14:26:20.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.303845 13448 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:20.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.303942 13448 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.305025 13448 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data/instance:
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "613ed1ae8f8048d09505bd628a29ff99"
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.305406 13448 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal/instance:
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "613ed1ae8f8048d09505bd628a29ff99"
14:26:20.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.306937 13448 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.001s
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.307821 13463 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.308050 13448 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.308117 13448 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "613ed1ae8f8048d09505bd628a29ff99"
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.308184 13448 fs_report.cc:389] FS layout report
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data/data
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:20.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:20.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:20.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:20.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.333737 13448 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:20.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.334146 13448 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:20.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.334285 13448 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:20.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.334614 13448 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:26:20.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.335009 13448 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:26:20.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.335109 13448 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:26:20.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.335146 13448 ts_tablet_manager.cc:616] Registered 0 tablets
14:26:20.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.335160 13448 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:26:20.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.341677 13448 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.129:32919
14:26:20.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.341828 13576 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.129:32919 every 8 connection(s)
14:26:20.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.342121 13448 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/data/info.pb
14:26:20.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.347575 13579 heartbeater.cc:344] Connected to a master server at 127.12.218.189:36713
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.347711 13579 heartbeater.cc:461] Registering TS with master...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.347914 13579 heartbeater.cc:507] Master 127.12.218.189:36713 requested a full tablet report, sending...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.347985 13577 heartbeater.cc:344] Connected to a master server at 127.12.218.190:45467
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348053 13577 heartbeater.cc:461] Registering TS with master...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348097 13578 heartbeater.cc:344] Connected to a master server at 127.12.218.188:39451
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348142 13578 heartbeater.cc:461] Registering TS with master...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348165 13577 heartbeater.cc:507] Master 127.12.218.190:45467 requested a full tablet report, sending...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348229 13578 heartbeater.cc:507] Master 127.12.218.188:39451 requested a full tablet report, sending...
14:26:20.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348379 13277 ts_manager.cc:194] Registered new tserver with Master: 613ed1ae8f8048d09505bd628a29ff99 (127.12.218.129:32919)
14:26:20.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348455 13205 ts_manager.cc:194] Registered new tserver with Master: 613ed1ae8f8048d09505bd628a29ff99 (127.12.218.129:32919)
14:26:20.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.348593 13350 ts_manager.cc:194] Registered new tserver with Master: 613ed1ae8f8048d09505bd628a29ff99 (127.12.218.129:32919)
14:26:20.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.349236 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13448
14:26:20.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.349234 13277 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.218.129:47341
14:26:20.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.349323 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-0/wal/instance
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.351552 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:20.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/logs
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data/info.pb
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.130:0
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.130
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.130
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:26:20.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.432277 13584 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:20.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.432461 13584 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:20.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.432482 13584 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:20.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.434875 13584 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:20.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.435000 13584 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.218.130
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.437858 13584 tablet_server_runner.cc:78] Tablet server non-default flags:
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.130:0
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data/info.pb
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.130
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13584
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:20.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.130
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/logs
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:20.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:20.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.438131 13584 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:20.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.438333 13584 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.440989 13593 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.440996 13590 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.440995 13591 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.441607 13584 server_base.cc:1061] running on GCE node
14:26:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.441742 13584 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:20.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.441956 13584 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:20.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.443148 13584 hybrid_clock.cc:648] HybridClock initialized: now 1779114380443121 us; error 33 us; skew 500 ppm
14:26:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.444383 13584 webserver.cc:533] Webserver started at http://127.12.218.130:43769/ using document root <none> and password file <none>
14:26:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.444542 13584 fs_manager.cc:362] Metadata directory not provided
14:26:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.444578 13584 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:20.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.444650 13584 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:20.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.445674 13584 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data/instance:
14:26:20.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c821697fdf5442fc9e9620528e977c13"
14:26:20.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.446079 13584 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal/instance:
14:26:20.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c821697fdf5442fc9e9620528e977c13"
14:26:20.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.447775 13584 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.003s	sys 0.000s
14:26:20.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.448583 13599 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:20.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.448887 13584 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.448953 13584 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c821697fdf5442fc9e9620528e977c13"
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.449000 13584 fs_report.cc:389] FS layout report
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data/data
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:20.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:20.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.468209 13584 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.468488 13584 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.468575 13584 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.468747 13584 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.469004 13584 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.469025 13584 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.469048 13584 ts_tablet_manager.cc:616] Registered 0 tablets
14:26:20.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.469060 13584 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:26:20.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.475131 13584 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.130:39375
14:26:20.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.475214 13712 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.130:39375 every 8 connection(s)
14:26:20.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.475459 13584 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/data/info.pb
14:26:20.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.476379 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13584
14:26:20.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.476469 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-1/wal/instance
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.477658 13162 external_mini_cluster.cc:1366] Running /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task9hSOIS/build/release/bin/kudu
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/logs
14:26:20.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data/info.pb
14:26:20.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:26:20.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:26:20.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.131:0
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.131
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.131
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481313 13713 heartbeater.cc:344] Connected to a master server at 127.12.218.190:45467
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481406 13713 heartbeater.cc:461] Registering TS with master...
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481446 13714 heartbeater.cc:344] Connected to a master server at 127.12.218.188:39451
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481503 13714 heartbeater.cc:461] Registering TS with master...
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481552 13713 heartbeater.cc:507] Master 127.12.218.190:45467 requested a full tablet report, sending...
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.481801 13714 heartbeater.cc:507] Master 127.12.218.188:39451 requested a full tablet report, sending...
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.482100 13205 ts_manager.cc:194] Registered new tserver with Master: c821697fdf5442fc9e9620528e977c13 (127.12.218.130:39375)
14:26:20.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.482126 13350 ts_manager.cc:194] Registered new tserver with Master: c821697fdf5442fc9e9620528e977c13 (127.12.218.130:39375)
14:26:20.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.482659 13715 heartbeater.cc:344] Connected to a master server at 127.12.218.189:36713
14:26:20.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.482713 13715 heartbeater.cc:461] Registering TS with master...
14:26:20.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.482780 13715 heartbeater.cc:507] Master 127.12.218.189:36713 requested a full tablet report, sending...
14:26:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.483035 13277 ts_manager.cc:194] Registered new tserver with Master: c821697fdf5442fc9e9620528e977c13 (127.12.218.130:39375)
14:26:20.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.483508 13277 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.218.130:44579
14:26:20.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.565760 13721 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:26:20.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.565997 13721 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:26:20.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.566030 13721 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:26:20.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.567993 13721 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:26:20.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.568282 13721 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.12.218.131
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.570099 13721 tablet_server_runner.cc:78] Tablet server non-default flags:
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.12.218.148:33033
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:26:20.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.12.218.131:0
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data/info.pb
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.12.218.131
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.12.218.190:45467,127.12.218.189:36713,127.12.218.188:39451
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13721
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.12.218.131
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/logs
14:26:20.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:45 UTC on e7f111948823
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15852
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.570410 13721 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:26:20.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.570684 13721 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:26:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.573771 13727 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.573848 13726 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:26:20.573760 13729 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
14:26:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.574586 13721 server_base.cc:1061] running on GCE node
14:26:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.574790 13721 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:26:20.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.575021 13721 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:26:20.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.576226 13721 hybrid_clock.cc:648] HybridClock initialized: now 1779114380576197 us; error 46 us; skew 500 ppm
14:26:20.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.577518 13721 webserver.cc:533] Webserver started at http://127.12.218.131:35487/ using document root <none> and password file <none>
14:26:20.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.577708 13721 fs_manager.cc:362] Metadata directory not provided
14:26:20.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.577747 13721 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:26:20.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.577831 13721 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.578699 13721 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data/instance:
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bdf3e6c7679483ebb183783e4fb25fb"
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.579113 13721 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal/instance:
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bdf3e6c7679483ebb183783e4fb25fb"
14:26:20.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.580930 13721 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.001s
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.581868 13735 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.582098 13721 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.582175 13721 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data,/tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6bdf3e6c7679483ebb183783e4fb25fb"
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:26:20 on dist-test-slave-78q2"
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.582228 13721 fs_report.cc:389] FS layout report
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data/data
14:26:20.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:26:20.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:26:20.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.601154 13721 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:26:20.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.601481 13721 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.601574 13721 kserver.cc:163] Server-wide thread pool size limit: 3276
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.601774 13721 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.602051 13721 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.602073 13721 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.602097 13721 ts_tablet_manager.cc:616] Registered 0 tablets
14:26:20.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.602109 13721 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:26:20.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.610049 13721 rpc_server.cc:307] RPC server started. Bound to: 127.12.218.131:46445
14:26:20.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.610242 13848 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.12.218.131:46445 every 8 connection(s)
14:26:20.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.610512 13721 server_base.cc:1193] Dumped server information to /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/data/info.pb
14:26:20.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.616214 13162 external_mini_cluster.cc:1428] Started /tmp/dist-test-task9hSOIS/build/release/bin/kudu as pid 13721
14:26:20.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.616393 13162 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task9hSOIS/test-tmp/mini-kudu-cluster13493076630979470783/ts-2/wal/instance
14:26:20.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617179 13849 heartbeater.cc:344] Connected to a master server at 127.12.218.190:45467
14:26:20.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617179 13850 heartbeater.cc:344] Connected to a master server at 127.12.218.188:39451
14:26:20.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617318 13849 heartbeater.cc:461] Registering TS with master...
14:26:20.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617332 13850 heartbeater.cc:461] Registering TS with master...
14:26:20.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617555 13850 heartbeater.cc:507] Master 127.12.218.188:39451 requested a full tablet report, sending...
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.617556 13849 heartbeater.cc:507] Master 127.12.218.190:45467 requested a full tablet report, sending...
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618005 13851 heartbeater.cc:344] Connected to a master server at 127.12.218.189:36713
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618052 13851 heartbeater.cc:461] Registering TS with master...
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618135 13851 heartbeater.cc:507] Master 127.12.218.189:36713 requested a full tablet report, sending...
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618222 13350 ts_manager.cc:194] Registered new tserver with Master: 6bdf3e6c7679483ebb183783e4fb25fb (127.12.218.131:46445)
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618281 13205 ts_manager.cc:194] Registered new tserver with Master: 6bdf3e6c7679483ebb183783e4fb25fb (127.12.218.131:46445)
14:26:20.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618387 13277 ts_manager.cc:194] Registered new tserver with Master: 6bdf3e6c7679483ebb183783e4fb25fb (127.12.218.131:46445)
14:26:20.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.618896 13277 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.12.218.131:43757
14:26:20.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.619877 13162 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:26:20.621 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:26:20.623 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:26:20.634 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.218.190"
      port: 45467
    }
    bound_http_address {
      host: "127.12.218.190"
      port: 35629
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.12.218.189"
      port: 36713
    }
    bound_http_address {
      host: "127.12.218.189"
      port: 34211
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.12.218.188"
      port: 39451
    }
    bound_http_address {
      host: "127.12.218.188"
      port: 39849
    }
  }
}

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

14:26:20.641 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.12.218.129"
      port: 32919
    }
    bound_http_address {
      host: "127.12.218.129"
      port: 36981
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.12.218.130"
      port: 39375
    }
    bound_http_address {
      host: "127.12.218.130"
      port: 43769
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.12.218.131"
      port: 46445
    }
    bound_http_address {
      host: "127.12.218.131"
      port: 35487
    }
  }
}

14:26:20.641 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:26:20.819 [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)
14:26:20.866 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
14:26:20.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.968415 13420 catalog_manager.cc:1295] Loaded cluster ID: bc1bae341b624942b05f0fac28ad1cb4
14:26:20.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.968498 13420 catalog_manager.cc:1588] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: loading cluster ID for follower catalog manager: success
14:26:20.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.969866 13420 catalog_manager.cc:1610] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: acquiring CA information for follower catalog manager: success
14:26:20.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:20.970204 13420 catalog_manager.cc:1638] T 00000000000000000000000000000000 P c7a8e2f3e19e4a948f5e88b86861dd2a: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:26:21.024 [DEBUG - main] (Connection.java:748) [peer master-127.12.218.189:36713(127.12.218.189:36713)] connecting to peer
14:26:21.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.040933 13434 catalog_manager.cc:1295] Loaded cluster ID: bc1bae341b624942b05f0fac28ad1cb4
14:26:21.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.041009 13434 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: loading cluster ID for follower catalog manager: success
14:26:21.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.042373 13434 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: acquiring CA information for follower catalog manager: success
14:26:21.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.042728 13434 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 94848f41b5f94624b86e2b7551abdba2: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
14:26:21.082 [DEBUG - main] (Connection.java:748) [peer master-127.12.218.188:39451(127.12.218.188:39451)] connecting to peer
14:26:21.083 [DEBUG - main] (Connection.java:748) [peer master-127.12.218.190:45467(127.12.218.190:45467)] connecting to peer
14:26:21.103 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.12.218.189:36713(127.12.218.189:36713)] Successfully connected to peer
14:26:21.103 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.12.218.188:39451(127.12.218.188:39451)] Successfully connected to peer
14:26:21.104 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.12.218.190:45467(127.12.218.190:45467)] Successfully connected to peer
14:26:21.195 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.218.188
14:26:21.195 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.218.190
14:26:21.195 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.12.218.189
14:26:21.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.350277 13579 heartbeater.cc:499] Master 127.12.218.189:36713 was elected leader, sending a full tablet report...
14:26:21.441 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x25895045, L:/127.0.0.1:53120 - R:/127.12.218.188:39451] using SASL/PLAIN
14:26:21.441 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x58a98dc3, L:/127.0.0.1:39416 - R:/127.12.218.189:36713] using SASL/PLAIN
14:26:21.444 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xd502734c, L:/127.0.0.1:36370 - R:/127.12.218.190:45467] using SASL/PLAIN
14:26:21.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.484138 13715 heartbeater.cc:499] Master 127.12.218.189:36713 was elected leader, sending a full tablet report...
14:26:21.491 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:26:21.493 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=504), Traces: [0ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.218.189:36713, [89ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.218.188:39451, [91ms] Sub RPC ConnectToMaster: sending RPC to server master-127.12.218.190:45467, [466ms] Sub RPC ConnectToMaster: received response from server master-127.12.218.190:45467: OK, [466ms] Sub RPC ConnectToMaster: received response from server master-127.12.218.188:39451: OK, [466ms] Sub RPC ConnectToMaster: received response from server master-127.12.218.189:36713: OK, deferred=null) after lookup
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.541854 13277 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:39416:
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestStatistics-1779114378370"
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:26:21.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:26:21.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:26:21.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:26:21.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:26:21.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.550499 13783 tablet_service.cc:1511] Processing CreateTablet for tablet 47e51e37e0b349c2a70908fb2c70ded4 (DEFAULT_TABLE table=org.apache.kudu.client.TestStatistics-1779114378370 [id=228be3d62b324e62b1067b9b35593dec]), partition=RANGE (key) PARTITION UNBOUNDED
14:26:21.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.550865 13783 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 47e51e37e0b349c2a70908fb2c70ded4. 1 dirs total, 0 dirs full, 0 dirs failed
14:26:21.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.553992 13876 tablet_bootstrap.cc:492] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: Bootstrap starting.
14:26:21.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.555992 13876 tablet_bootstrap.cc:654] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: Neither blocks nor log segments found. Creating new log.
14:26:21.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.556937 13876 log.cc:826] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: Log is configured to *not* fsync() on all Append() calls
14:26:21.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.558948 13876 tablet_bootstrap.cc:492] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: No bootstrap required, opened a new log
14:26:21.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.559080 13876 ts_tablet_manager.cc:1403] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: Time spent bootstrapping tablet: real 0.005s	user 0.001s	sys 0.002s
14:26:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.561712 13876 raft_consensus.cc:359] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" member_type: VOTER last_known_addr { host: "127.12.218.131" port: 46445 } }
14:26:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.561933 13876 raft_consensus.cc:385] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:26:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.561971 13876 raft_consensus.cc:740] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6bdf3e6c7679483ebb183783e4fb25fb, State: Initialized, Role: FOLLOWER
14:26:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.562764 13876 consensus_queue.cc:260] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [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: true peers { permanent_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" member_type: VOTER last_known_addr { host: "127.12.218.131" port: 46445 } }
14:26:21.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.562880 13876 raft_consensus.cc:399] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.563117 13876 raft_consensus.cc:493] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.563201 13876 raft_consensus.cc:3060] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 0 FOLLOWER]: Advancing to term 1
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.564378 13876 raft_consensus.cc:515] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" member_type: VOTER last_known_addr { host: "127.12.218.131" port: 46445 } }
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.564575 13876 leader_election.cc:304] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 6bdf3e6c7679483ebb183783e4fb25fb; no voters: 
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.564815 13876 leader_election.cc:290] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [CANDIDATE]: Term 1 election: Requested vote from peers 
14:26:21.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.565132 13876 ts_tablet_manager.cc:1434] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb: Time spent starting tablet: real 0.006s	user 0.005s	sys 0.001s
14:26:21.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.568485 13851 heartbeater.cc:499] Master 127.12.218.189:36713 was elected leader, sending a full tablet report...
14:26:21.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.568594 13878 raft_consensus.cc:2804] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 1 FOLLOWER]: Leader election won for term 1
14:26:21.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.568790 13878 raft_consensus.cc:697] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [term 1 LEADER]: Becoming Leader. State: Replica: 6bdf3e6c7679483ebb183783e4fb25fb, State: Running, Role: LEADER
14:26:21.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.568881 13878 consensus_queue.cc:237] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb [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: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" member_type: VOTER last_known_addr { host: "127.12.218.131" port: 46445 } }
14:26:21.573 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 228be3d62b324e62b1067b9b35593dec
14:26:21.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.570219 13277 catalog_manager.cc:5697] T 47e51e37e0b349c2a70908fb2c70ded4 P 6bdf3e6c7679483ebb183783e4fb25fb reported cstate change: term changed from 0 to 1, leader changed from <none> to 6bdf3e6c7679483ebb183783e4fb25fb (127.12.218.131). New cstate: current_term: 1 leader_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "6bdf3e6c7679483ebb183783e4fb25fb" member_type: VOTER last_known_addr { host: "127.12.218.131" port: 46445 } health_report { overall_health: HEALTHY } } }
14:26:21.626 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 47e51e37e0b349c2a70908fb2c70ded4 for table 'org.apache.kudu.client.TestStatistics-1779114378370' with partition [<start>, <end>)
14:26:21.628 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@2014536862(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.633 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=47e51e37e0b349c2a70908fb2c70ded4@[6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)[L]]}]
14:26:21.638 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 47e51e37e0b349c2a70908fb2c70ded4 for table 'org.apache.kudu.client.TestStatistics-1779114378370' with partition [<start>, <end>)
14:26:21.638 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=47e51e37e0b349c2a70908fb2c70ded4@[6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)[L]]}]
14:26:21.648 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)] connecting to peer
14:26:21.651 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)] Successfully connected to peer
14:26:21.723 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xd583b31c, L:/127.0.0.1:37174 - R:/127.12.218.131:46445] using TOKEN/null
14:26:21.744 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1174068586(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.748 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@648967903(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.751 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@604117225(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.755 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1107471400(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.758 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1367353487(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.762 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@80590062(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.765 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@809247182(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.769 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1737009165(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.773 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@924590115(state=PENDING, result=null, callback=<none>, errback=<none>)}
14:26:21.874 [DEBUG - main] (Connection.java:575) [peer master-127.12.218.190:45467(127.12.218.190:45467)] disconnecting while in state READY
14:26:21.880 [DEBUG - main] (Connection.java:575) [peer master-127.12.218.188:39451(127.12.218.188:39451)] disconnecting while in state READY
14:26:21.881 [DEBUG - main] (Connection.java:575) [peer master-127.12.218.189:36713(127.12.218.189:36713)] disconnecting while in state READY
14:26:21.881 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.12.218.190:45467(127.12.218.190:45467)] handling channelInactive
14:26:21.882 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.12.218.188:39451(127.12.218.188:39451)] handling channelInactive
14:26:21.882 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.12.218.189:36713(127.12.218.189:36713)] handling channelInactive
14:26:21.882 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.12.218.190:45467(127.12.218.190:45467)] cleaning up while in state READY due to: connection closed
14:26:21.882 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.12.218.188:39451(127.12.218.188:39451)] cleaning up while in state READY due to: connection closed
14:26:21.882 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.12.218.189:36713(127.12.218.189:36713)] cleaning up while in state READY due to: connection closed
14:26:21.883 [DEBUG - main] (Connection.java:575) [peer 6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)] disconnecting while in state READY
14:26:21.884 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:26:21.888 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)] handling channelInactive
14:26:21.889 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 6bdf3e6c7679483ebb183783e4fb25fb(127.12.218.131:46445)] cleaning up while in state READY due to: connection closed
14:26:21.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.888613 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13448
14:26:21.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.895924 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13584
14:26:21.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.904623 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13721
14:26:21.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.911751 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13173
14:26:21.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.917982 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13244
14:26:21.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:26:21.923539 13162 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task9hSOIS/build/release/bin/kudu with pid 13318
14:26:21.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:26:21Z chronyd exiting

Time: 3.407

OK (1 test)

