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

18:18:36.741 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:18:36.742 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:18:36.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.744907 21065 mini_oidc.cc:150] Starting JWKS server
18:18:36.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.746999 21065 webserver.cc:534] Webserver started at http://127.0.0.1:37507/ using document root <none> and password file <none>
18:18:36.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.747190 21065 mini_oidc.cc:186] Starting OIDC Discovery server
18:18:36.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.747512 21065 webserver.cc:534] Webserver started at http://127.0.0.1:36491/ using document root <none> and password file <none>
18:18:36.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:18:36Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:18:36.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:18:36Z Disabled control of system clock
18:18:36.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.766244 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:36.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:36.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal
18:18:36.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data
18:18:36.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:36.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:36.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:36.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:36.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:36.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:36.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/logs
18:18:36.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data/info.pb
18:18:36.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:36.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:36.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:36.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:36.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:36.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:36.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:36.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:36.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:18:36.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:36.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:36.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:36.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.126:39103
18:18:36.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.126
18:18:36.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:36.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:36.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:36.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json with env {}
18:18:36.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.869686 21076 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:36.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.869933 21076 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:36.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.869979 21076 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:36.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874137 21076 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:18:36.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874210 21076 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:36.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874233 21076 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:18:36.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874251 21076 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:18:36.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874270 21076 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:18:36.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.874284 21076 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:37507/jwks.json
18:18:36.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.878669 21076 master_runner.cc:387] Master server non-default flags:
18:18:36.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:36.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:36.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:36.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:36.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.126:39103
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:36.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data/info.pb
18:18:36.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.126
18:18:36.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:36.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:36.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21076
18:18:36.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/logs
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:36.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:36.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.880084 21076 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:36.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.881316 21076 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:36.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.888669 21081 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:36.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.888888 21084 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:36.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.888888 21082 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:36.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.889186 21076 server_base.cc:1061] running on GCE node
18:18:36.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.891048 21076 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:36.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.892011 21076 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:36.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.893179 21076 hybrid_clock.cc:648] HybridClock initialized: now 1783534716893169 us; error 31 us; skew 500 ppm
18:18:36.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.894956 21076 webserver.cc:534] Webserver started at http://127.20.146.126:39551/ using document root <none> and password file <none>
18:18:36.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.895542 21076 fs_manager.cc:362] Metadata directory not provided
18:18:36.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.895601 21076 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:36.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.895756 21076 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:36.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.897368 21076 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data/instance:
18:18:36.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66561ca5218745889d3b9e96f522335a"
18:18:36.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:36 on dist-test-slave-0njz"
18:18:36.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.897809 21076 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal/instance:
18:18:36.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66561ca5218745889d3b9e96f522335a"
18:18:36.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:36 on dist-test-slave-0njz"
18:18:36.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.902164 21076 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.003s
18:18:36.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.905284 21090 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:36.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.906457 21076 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
18:18:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.906566 21076 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal
18:18:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "66561ca5218745889d3b9e96f522335a"
18:18:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:36 on dist-test-slave-0njz"
18:18:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.906647 21076 fs_report.cc:389] FS layout report
18:18:36.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:36.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal
18:18:36.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal
18:18:36.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data/data
18:18:36.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:36.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:36.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:36.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:36.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:36.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.919636 21076 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:36.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.920256 21076 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
18:18:36.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.920404 21076 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:36.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.928274 21076 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.126:39103
18:18:36.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.928299 21142 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.126:39103 every 8 connection(s)
18:18:36.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.929224 21076 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/data/info.pb
18:18:36.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.932145 21143 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:18:36.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.932652 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21076
18:18:36.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.932832 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-0/wal/instance
18:18:36.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.934235 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:36.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:36.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:36.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/logs
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data/info.pb
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:36.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:36.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.125:35285
18:18:36.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.125
18:18:36.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:36.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:36.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:36.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:36.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:36.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:36.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:36.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:36.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json with env {}
18:18:36.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.935547 21143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } has no permanent_uuid. Determining permanent_uuid...
18:18:36.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:36.953742 21143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } has no permanent_uuid. Determining permanent_uuid...
18:18:36.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.954726 21091 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.20.146.125:35285: connect: Connection refused (error 111)
18:18:36.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:36.956168 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.125:35285: Network error: Client connection negotiation failed: client connection to 127.20.146.125:35285: connect: Connection refused (error 111)
18:18:37.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.005440 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } attempt: 1
18:18:37.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.008073 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.125:35285: Network error: Client connection negotiation failed: client connection to 127.20.146.125:35285: connect: Connection refused (error 111)
18:18:37.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.063649 21145 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:37.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.063937 21145 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:37.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.064002 21145 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:37.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070102 21145 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:18:37.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070242 21145 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:37.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070277 21145 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:18:37.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070305 21145 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:18:37.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070333 21145 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:18:37.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.070353 21145 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:37507/jwks.json
18:18:37.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.076508 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } attempt: 2
18:18:37.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.076706 21145 master_runner.cc:387] Master server non-default flags:
18:18:37.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.125:35285
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json
18:18:37.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data/info.pb
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.125
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:37.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21145
18:18:37.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:37.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:37.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/logs
18:18:37.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:37.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:37.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:18:37.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:37.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:37.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:37.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:37.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:37.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.078265 21145 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:37.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.078886 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.125:35285: Network error: Client connection negotiation failed: client connection to 127.20.146.125:35285: connect: Connection refused (error 111)
18:18:37.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.079873 21145 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:37.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.089010 21154 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.088995 21153 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.088995 21156 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.090031 21145 server_base.cc:1061] running on GCE node
18:18:37.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.092099 21145 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:37.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.093304 21145 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:37.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.094592 21145 hybrid_clock.cc:648] HybridClock initialized: now 1783534717094568 us; error 44 us; skew 500 ppm
18:18:37.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.096912 21145 webserver.cc:534] Webserver started at http://127.20.146.125:39295/ using document root <none> and password file <none>
18:18:37.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.097497 21145 fs_manager.cc:362] Metadata directory not provided
18:18:37.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.097551 21145 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:37.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.097791 21145 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.100605 21145 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data/instance:
18:18:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf8d018b4698406590df3233d57ee28b"
18:18:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.101258 21145 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal/instance:
18:18:37.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf8d018b4698406590df3233d57ee28b"
18:18:37.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.106208 21145 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
18:18:37.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.109045 21162 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:37.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.110106 21145 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
18:18:37.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.110210 21145 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal
18:18:37.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf8d018b4698406590df3233d57ee28b"
18:18:37.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.110291 21145 fs_report.cc:389] FS layout report
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data/data
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:37.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:37.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:37.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:37.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:37.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.129747 21145 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:37.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.130398 21145 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
18:18:37.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.130630 21145 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:37.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.138339 21145 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.125:35285
18:18:37.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.138327 21214 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.125:35285 every 8 connection(s)
18:18:37.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.139420 21145 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/data/info.pb
18:18:37.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.142213 21215 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:18:37.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.143697 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21145
18:18:37.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.143786 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-1/wal/instance
18:18:37.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.144538 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:37.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/logs
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data/info.pb
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:37.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.124:39985
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.124
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:37.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json with env {}
18:18:37.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.145565 21215 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.158038 21215 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.165195 21215 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.165979 21164 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.166949 21215 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.170078 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } attempt: 3
18:18:37.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.174867 21143 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.176424 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.207716 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 1
18:18:37.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.209565 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.216198 21215 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 1
18:18:37.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.217901 21215 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.262665 21217 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:37.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.262992 21217 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:37.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.263049 21217 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:37.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268087 21217 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:18:37.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268201 21217 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:37.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268227 21217 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:18:37.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268249 21217 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:18:37.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268271 21217 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:18:37.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.268288 21217 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:37507/jwks.json
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.273948 21217 master_runner.cc:387] Master server non-default flags:
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:18:37.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.124:39985
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:18:37.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37507/jwks.json
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data/info.pb
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.124
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21217
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:37.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/logs
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:37.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:37.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:37.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:37.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.275795 21217 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:37.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.278251 21217 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:37.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.284852 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 2
18:18:37.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.285498 21226 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.285899 21217 server_base.cc:1061] running on GCE node
18:18:37.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.285498 21228 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.286360 21215 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 2
18:18:37.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.286841 21143 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.286916 21225 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.287951 21217 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:37.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.288198 21215 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.146.124:39985: Network error: Client connection negotiation failed: client connection to 127.20.146.124:39985: connect: Connection refused (error 111)
18:18:37.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.289129 21217 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:37.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.290337 21217 hybrid_clock.cc:648] HybridClock initialized: now 1783534717290284 us; error 71 us; skew 500 ppm
18:18:37.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.292984 21217 webserver.cc:534] Webserver started at http://127.20.146.124:41631/ using document root <none> and password file <none>
18:18:37.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.293886 21217 fs_manager.cc:362] Metadata directory not provided
18:18:37.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.294000 21217 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:37.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.294297 21217 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:37.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.296388 21217 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data/instance:
18:18:37.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ef6d8ced33e748a38a1b741e0ac7e158"
18:18:37.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.296993 21217 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal/instance:
18:18:37.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ef6d8ced33e748a38a1b741e0ac7e158"
18:18:37.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.300653 21217 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
18:18:37.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.303407 21234 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.304838 21217 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.304986 21217 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ef6d8ced33e748a38a1b741e0ac7e158"
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.305094 21217 fs_report.cc:389] FS layout report
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:37.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data/data
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:37.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:37.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:37.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:37.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:37.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:37.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:37.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.320519 21217 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:37.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.321297 21217 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
18:18:37.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.321504 21217 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:37.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.328737 21217 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.124:39985
18:18:37.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.328774 21286 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.124:39985 every 8 connection(s)
18:18:37.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.329830 21217 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/data/info.pb
18:18:37.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.331887 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21217
18:18:37.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.331995 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/master-2/wal/instance
18:18:37.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.333109 21287 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:18:37.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.336714 21287 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.344537 21287 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.348759 21287 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } has no permanent_uuid. Determining permanent_uuid...
18:18:37.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.355369 21287 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: Bootstrap starting.
18:18:37.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.357568 21287 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: Neither blocks nor log segments found. Creating new log.
18:18:37.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.358388 21287 log.cc:826] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: Log is configured to *not* fsync() on all Append() calls
18:18:37.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.360018 21287 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: No bootstrap required, opened a new log
18:18:37.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.363323 21287 raft_consensus.cc:359] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.363490 21287 raft_consensus.cc:385] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:18:37.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.363524 21287 raft_consensus.cc:740] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ef6d8ced33e748a38a1b741e0ac7e158, State: Initialized, Role: FOLLOWER
18:18:37.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.363934 21287 consensus_queue.cc:260] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [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: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.364490 21296 sys_catalog.cc:455] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [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: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.364629 21296 sys_catalog.cc:458] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.364948 21287 sys_catalog.cc:565] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: configured and running, proceeding with master startup.
18:18:37.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.369858 21307 catalog_manager.cc:1593] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:18:37.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.369951 21307 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:18:37.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.368453 21217 master_runner.cc:187] Error getting master registration for 127.20.146.126:39103: OK, instance_id { permanent_uuid: "66561ca5218745889d3b9e96f522335a" instance_seqno: 1783534716926156 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:18:37.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.371369 21217 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:18:37.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.372110 21296 raft_consensus.cc:493] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:18:37.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.372251 21296 raft_consensus.cc:515] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.373194 21296 leader_election.cc:290] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 66561ca5218745889d3b9e96f522335a (127.20.146.126:39103), bf8d018b4698406590df3233d57ee28b (127.20.146.125:35285)
18:18:37.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.379365 21215 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 3
18:18:37.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.385944 21143 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } attempt: 3
18:18:37.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.387140 21215 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: Bootstrap starting.
18:18:37.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.390429 21215 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: Neither blocks nor log segments found. Creating new log.
18:18:37.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.391685 21215 log.cc:826] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: Log is configured to *not* fsync() on all Append() calls
18:18:37.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.393863 21215 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: No bootstrap required, opened a new log
18:18:37.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.397746 21215 raft_consensus.cc:359] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.397948 21215 raft_consensus.cc:385] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:18:37.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.398005 21215 raft_consensus.cc:740] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bf8d018b4698406590df3233d57ee28b, State: Initialized, Role: FOLLOWER
18:18:37.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.398452 21215 consensus_queue.cc:260] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [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: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.398716 21143 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: Bootstrap starting.
18:18:37.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.399655 21215 sys_catalog.cc:565] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: configured and running, proceeding with master startup.
18:18:37.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.399732 21189 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bf8d018b4698406590df3233d57ee28b" is_pre_election: true
18:18:37.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.400167 21189 raft_consensus.cc:2468] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ef6d8ced33e748a38a1b741e0ac7e158 in term 0.
18:18:37.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.400600 21235 leader_election.cc:304] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [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: bf8d018b4698406590df3233d57ee28b, ef6d8ced33e748a38a1b741e0ac7e158; no voters: 
18:18:37.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.400967 21296 raft_consensus.cc:2804] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.401067 21296 raft_consensus.cc:493] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.401114 21296 raft_consensus.cc:3060] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 0 FOLLOWER]: Advancing to term 1
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.402278 21296 raft_consensus.cc:515] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.402684 21296 leader_election.cc:290] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [CANDIDATE]: Term 1 election: Requested vote from peers 66561ca5218745889d3b9e96f522335a (127.20.146.126:39103), bf8d018b4698406590df3233d57ee28b (127.20.146.125:35285)
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.403321 21189 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bf8d018b4698406590df3233d57ee28b"
18:18:37.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.403427 21189 raft_consensus.cc:3060] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 0 FOLLOWER]: Advancing to term 1
18:18:37.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.404536 21189 raft_consensus.cc:2468] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ef6d8ced33e748a38a1b741e0ac7e158 in term 1.
18:18:37.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.404983 21143 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: Neither blocks nor log segments found. Creating new log.
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.406158 21143 log.cc:826] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: Log is configured to *not* fsync() on all Append() calls
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.406224 21235 leader_election.cc:304] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [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: bf8d018b4698406590df3233d57ee28b, ef6d8ced33e748a38a1b741e0ac7e158; no voters: 
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.406424 21296 raft_consensus.cc:2804] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 1 FOLLOWER]: Leader election won for term 1
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.406598 21296 raft_consensus.cc:697] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [term 1 LEADER]: Becoming Leader. State: Replica: ef6d8ced33e748a38a1b741e0ac7e158, State: Running, Role: LEADER
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.406942 21296 consensus_queue.cc:237] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [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: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.408560 21296 sys_catalog.cc:455] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ef6d8ced33e748a38a1b741e0ac7e158. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.408658 21296 sys_catalog.cc:458] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: This master's current role is: LEADER
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.407120 21145 master_runner.cc:187] Error getting master registration for 127.20.146.126:39103: OK, instance_id { permanent_uuid: "66561ca5218745889d3b9e96f522335a" instance_seqno: 1783534716926156 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:18:37.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.409538 21145 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:18:37.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.411477 21310 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.412179 21310 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.412680 21143 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: No bootstrap required, opened a new log
18:18:37.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.413928 21321 catalog_manager.cc:1593] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:18:37.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.413985 21321 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:18:37.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.416131 21143 raft_consensus.cc:359] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.416322 21143 raft_consensus.cc:385] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:18:37.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.416374 21143 raft_consensus.cc:740] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 66561ca5218745889d3b9e96f522335a, State: Initialized, Role: FOLLOWER
18:18:37.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.416894 21143 consensus_queue.cc:260] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [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: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } }
18:18:37.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.419673 21325 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.419721 21143 sys_catalog.cc:565] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: configured and running, proceeding with master startup.
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.419796 21117 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "66561ca5218745889d3b9e96f522335a" is_pre_election: true
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.420037 21117 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ef6d8ced33e748a38a1b741e0ac7e158 in term 0.
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.420615 21113 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "66561ca5218745889d3b9e96f522335a"
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.420747 21325 catalog_manager.cc:1519] Initializing Kudu cluster ID...
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.420733 21113 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 0 FOLLOWER]: Advancing to term 1
18:18:37.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.422066 21113 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ef6d8ced33e748a38a1b741e0ac7e158 in term 1.
18:18:37.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.422399 21096 tablet.cc:2406] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:18:37.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.428514 21327 sys_catalog.cc:455] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.429030 21327 sys_catalog.cc:458] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.429548 21338 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:18:37.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.430114 21338 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:18:37.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.444684 21189 raft_consensus.cc:1275] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [term 1 FOLLOWER]: Refusing update from remote peer ef6d8ced33e748a38a1b741e0ac7e158: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:18:37.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.444684 21113 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [term 1 FOLLOWER]: Refusing update from remote peer ef6d8ced33e748a38a1b741e0ac7e158: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:18:37.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.445379 21296 consensus_queue.cc:1048] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [LEADER]: Connected to new peer: Peer: permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:18:37.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.445524 21323 consensus_queue.cc:1048] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [LEADER]: Connected to new peer: Peer: permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:18:37.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.449735 21327 sys_catalog.cc:455] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: SysCatalogTable state changed. Reason: New leader ef6d8ced33e748a38a1b741e0ac7e158. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.449856 21327 sys_catalog.cc:458] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.450668 21310 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: SysCatalogTable state changed. Reason: New leader ef6d8ced33e748a38a1b741e0ac7e158. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.450776 21310 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.457206 21323 sys_catalog.cc:455] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.457347 21323 sys_catalog.cc:458] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: This master's current role is: LEADER
18:18:37.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.458617 21310 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.458724 21310 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.460769 21296 sys_catalog.cc:455] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.460877 21296 sys_catalog.cc:458] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158 [sys.catalog]: This master's current role is: LEADER
18:18:37.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.461925 21327 sys_catalog.cc:455] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "66561ca5218745889d3b9e96f522335a" member_type: VOTER last_known_addr { host: "127.20.146.126" port: 39103 } } peers { permanent_uuid: "bf8d018b4698406590df3233d57ee28b" member_type: VOTER last_known_addr { host: "127.20.146.125" port: 35285 } } peers { permanent_uuid: "ef6d8ced33e748a38a1b741e0ac7e158" member_type: VOTER last_known_addr { host: "127.20.146.124" port: 39985 } } }
18:18:37.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.462033 21327 sys_catalog.cc:458] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a [sys.catalog]: This master's current role is: FOLLOWER
18:18:37.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.463267 21343 mvcc.cc:204] Tried to move back new op lower bound from 7305358202595737600 to 7305358202501652480. Current Snapshot: MvccSnapshot[applied={T|T < 7305358202595737600 or (T in {7305358202595737600})}]
18:18:37.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.463611 21341 mvcc.cc:204] Tried to move back new op lower bound from 7305358202595737600 to 7305358202501652480. Current Snapshot: MvccSnapshot[applied={T|T < 7305358202595737600}]
18:18:37.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.465438 21325 catalog_manager.cc:1382] Generated new cluster ID: b1e2c697c701417181fc8f5e77b00d43
18:18:37.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.465493 21325 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
18:18:37.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.489555 21325 catalog_manager.cc:1405] Generated new certificate authority record
18:18:37.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.491235 21325 catalog_manager.cc:1539] Loading token signing keys...
18:18:37.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.509244 21325 catalog_manager.cc:6069] T 00000000000000000000000000000000 P ef6d8ced33e748a38a1b741e0ac7e158: Generated new TSK 0
18:18:37.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.510538 21325 catalog_manager.cc:1549] Initializing in-progress tserver states...
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.522447 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:37.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/logs
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data/info.pb
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.65:0
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.65
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.65
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:18:37.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.668706 21348 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:37.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.668972 21348 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:37.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.669035 21348 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:37.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.673197 21348 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:37.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.673374 21348 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.146.65
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.677748 21348 tablet_server_runner.cc:78] Tablet server non-default flags:
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:37.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.65:0
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data/info.pb
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.65
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21348
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.65
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/logs
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:37.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:37.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:37.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:37.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:37.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.679179 21348 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:37.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.680658 21348 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:37.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.688431 21353 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.688441 21354 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.689915 21348 server_base.cc:1061] running on GCE node
18:18:37.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.690899 21356 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.691753 21348 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:37.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.692371 21348 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:37.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.693573 21348 hybrid_clock.cc:648] HybridClock initialized: now 1783534717693526 us; error 64 us; skew 500 ppm
18:18:37.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.695998 21348 webserver.cc:534] Webserver started at http://127.20.146.65:33303/ using document root <none> and password file <none>
18:18:37.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.696630 21348 fs_manager.cc:362] Metadata directory not provided
18:18:37.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.696717 21348 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:37.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.696949 21348 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:37.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.698649 21348 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data/instance:
18:18:37.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3329ea377b924f83baf050f285fab8ce"
18:18:37.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.699234 21348 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal/instance:
18:18:37.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3329ea377b924f83baf050f285fab8ce"
18:18:37.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.702947 21348 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
18:18:37.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.705260 21362 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:37.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.706364 21348 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.000s	sys 0.002s
18:18:37.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.706496 21348 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal
18:18:37.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3329ea377b924f83baf050f285fab8ce"
18:18:37.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.706597 21348 fs_report.cc:389] FS layout report
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data/data
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:37.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:37.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:37.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:37.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:37.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:37.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:37.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.731698 21348 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:37.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.732542 21348 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
18:18:37.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.732780 21348 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:37.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.733415 21348 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:18:37.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.734515 21348 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:18:37.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.734589 21348 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:18:37.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.734647 21348 ts_tablet_manager.cc:616] Registered 0 tablets
18:18:37.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.734679 21348 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:18:37.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.744149 21348 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.65:36189
18:18:37.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.744238 21475 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.65:36189 every 8 connection(s)
18:18:37.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.745277 21348 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/data/info.pb
18:18:37.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.745793 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21348
18:18:37.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.745908 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-0/wal/instance
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.748972 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/logs
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data/info.pb
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.66:0
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.66
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.66
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.756945 21477 heartbeater.cc:344] Connected to a master server at 127.20.146.126:39103
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757028 21478 heartbeater.cc:344] Connected to a master server at 127.20.146.125:35285
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757191 21478 heartbeater.cc:461] Registering TS with master...
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757220 21476 heartbeater.cc:344] Connected to a master server at 127.20.146.124:39985
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757190 21477 heartbeater.cc:461] Registering TS with master...
18:18:37.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757407 21476 heartbeater.cc:461] Registering TS with master...
18:18:37.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757965 21476 heartbeater.cc:507] Master 127.20.146.124:39985 requested a full tablet report, sending...
18:18:37.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.757963 21477 heartbeater.cc:507] Master 127.20.146.126:39103 requested a full tablet report, sending...
18:18:37.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.758155 21478 heartbeater.cc:507] Master 127.20.146.125:35285 requested a full tablet report, sending...
18:18:37.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.759598 21251 ts_manager.cc:194] Registered new tserver with Master: 3329ea377b924f83baf050f285fab8ce (127.20.146.65:36189)
18:18:37.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.759598 21106 ts_manager.cc:194] Registered new tserver with Master: 3329ea377b924f83baf050f285fab8ce (127.20.146.65:36189)
18:18:37.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.759841 21179 ts_manager.cc:194] Registered new tserver with Master: 3329ea377b924f83baf050f285fab8ce (127.20.146.65:36189)
18:18:37.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.760959 21251 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.146.65:34779
18:18:37.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.859959 21483 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:37.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.860185 21483 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:37.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.860227 21483 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:37.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.863586 21483 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:37.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.863685 21483 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.146.66
18:18:37.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.867746 21483 tablet_server_runner.cc:78] Tablet server non-default flags:
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.66:0
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data/info.pb
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.66
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21483
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.66
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/logs
18:18:37.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.868711 21483 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:37.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.869694 21483 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:37.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.875507 21489 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.875681 21488 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:37.875710 21491 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:37.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.876487 21483 server_base.cc:1061] running on GCE node
18:18:37.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.876788 21483 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:37.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.877231 21483 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:37.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.878412 21483 hybrid_clock.cc:648] HybridClock initialized: now 1783534717878386 us; error 44 us; skew 500 ppm
18:18:37.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.880271 21483 webserver.cc:534] Webserver started at http://127.20.146.66:33165/ using document root <none> and password file <none>
18:18:37.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.880825 21483 fs_manager.cc:362] Metadata directory not provided
18:18:37.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.880879 21483 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:37.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.881026 21483 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.882449 21483 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data/instance:
18:18:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3eb84cc3b24948eb90cc7a24e6f198ec"
18:18:37.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.883093 21483 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal/instance:
18:18:37.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3eb84cc3b24948eb90cc7a24e6f198ec"
18:18:37.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.886912 21483 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.001s
18:18:37.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.889293 21497 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:37.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.890389 21483 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
18:18:37.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.890482 21483 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal
18:18:37.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3eb84cc3b24948eb90cc7a24e6f198ec"
18:18:37.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:37 on dist-test-slave-0njz"
18:18:37.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.890550 21483 fs_report.cc:389] FS layout report
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data/data
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:37.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:37.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.920109 21483 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:37.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.920856 21483 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
18:18:37.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.921013 21483 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:37.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.921680 21483 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:18:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.923183 21483 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:18:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.923352 21483 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:18:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.923404 21483 ts_tablet_manager.cc:616] Registered 0 tablets
18:18:37.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.923420 21483 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:18:37.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.937351 21483 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.66:40535
18:18:37.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.937395 21610 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.66:40535 every 8 connection(s)
18:18:37.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.938868 21483 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/data/info.pb
18:18:37.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.946292 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21483
18:18:37.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.946411 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-1/wal/instance
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.949784 21613 heartbeater.cc:344] Connected to a master server at 127.20.146.125:35285
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.950073 21613 heartbeater.cc:461] Registering TS with master...
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.950350 21065 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:37.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/logs
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data/info.pb
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.67:0
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.67
18:18:37.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.67
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.950685 21613 heartbeater.cc:507] Master 127.20.146.125:35285 requested a full tablet report, sending...
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.951258 21611 heartbeater.cc:344] Connected to a master server at 127.20.146.124:39985
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.951337 21611 heartbeater.cc:461] Registering TS with master...
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.951534 21611 heartbeater.cc:507] Master 127.20.146.124:39985 requested a full tablet report, sending...
18:18:37.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.951954 21179 ts_manager.cc:194] Registered new tserver with Master: 3eb84cc3b24948eb90cc7a24e6f198ec (127.20.146.66:40535)
18:18:37.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.953104 21612 heartbeater.cc:344] Connected to a master server at 127.20.146.126:39103
18:18:37.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.953123 21251 ts_manager.cc:194] Registered new tserver with Master: 3eb84cc3b24948eb90cc7a24e6f198ec (127.20.146.66:40535)
18:18:37.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.953191 21612 heartbeater.cc:461] Registering TS with master...
18:18:37.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.953347 21612 heartbeater.cc:507] Master 127.20.146.126:39103 requested a full tablet report, sending...
18:18:37.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.954020 21251 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.146.66:38359
18:18:37.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:37.954355 21106 ts_manager.cc:194] Registered new tserver with Master: 3eb84cc3b24948eb90cc7a24e6f198ec (127.20.146.66:40535)
18:18:38.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.058732 21618 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:18:38.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.058957 21618 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:18:38.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.058998 21618 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:18:38.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.062321 21618 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:18:38.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.062425 21618 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.146.67
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.066802 21618 tablet_server_runner.cc:78] Tablet server non-default flags:
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.146.84:41939
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.146.67:0
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data/info.pb
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.146.67
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:18:38.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.146.126:39103,127.20.146.125:35285,127.20.146.124:39985
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.21618
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.146.67
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/logs
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:18:38.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on bdcb31816ec0
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16868
18:18:38.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.068539 21618 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:18:38.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.070487 21618 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:18:38.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.078428 21626 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:38.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.078469 21623 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:38.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.078521 21618 server_base.cc:1061] running on GCE node
18:18:38.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:18:38.078648 21624 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:18:38.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.079603 21618 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:18:38.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.080226 21618 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:18:38.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.081492 21618 hybrid_clock.cc:648] HybridClock initialized: now 1783534718081462 us; error 31 us; skew 500 ppm
18:18:38.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.084162 21618 webserver.cc:534] Webserver started at http://127.20.146.67:45987/ using document root <none> and password file <none>
18:18:38.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.084832 21618 fs_manager.cc:362] Metadata directory not provided
18:18:38.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.084923 21618 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:18:38.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.085206 21618 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.086823 21618 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data/instance:
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8f60378aaea427e9e630bc072fd339d"
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:38 on dist-test-slave-0njz"
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.087407 21618 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal/instance:
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8f60378aaea427e9e630bc072fd339d"
18:18:38.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:38 on dist-test-slave-0njz"
18:18:38.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.091444 21618 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
18:18:38.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.094269 21632 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.095654 21618 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.096033 21618 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data,/tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c8f60378aaea427e9e630bc072fd339d"
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:18:38 on dist-test-slave-0njz"
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.096283 21618 fs_report.cc:389] FS layout report
18:18:38.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data/data
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:18:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:18:38.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.113119 21618 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:18:38.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.113884 21618 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
18:18:38.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.114091 21618 kserver.cc:163] Server-wide thread pool size limit: 3276
18:18:38.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.114701 21618 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:18:38.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.116014 21618 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:18:38.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.116099 21618 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:18:38.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.116158 21618 ts_tablet_manager.cc:616] Registered 0 tablets
18:18:38.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.116181 21618 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:18:38.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.127410 21618 rpc_server.cc:307] RPC server started. Bound to: 127.20.146.67:32971
18:18:38.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.127482 21745 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.146.67:32971 every 8 connection(s)
18:18:38.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.128523 21618 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/data/info.pb
18:18:38.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.128842 21065 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu as pid 21618
18:18:38.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.128957 21065 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskSP9Aay/test-tmp/mini-kudu-cluster4056275150245719917/ts-2/wal/instance
18:18:38.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.140954 21746 heartbeater.cc:344] Connected to a master server at 127.20.146.124:39985
18:18:38.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.141218 21746 heartbeater.cc:461] Registering TS with master...
18:18:38.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.141722 21746 heartbeater.cc:507] Master 127.20.146.124:39985 requested a full tablet report, sending...
18:18:38.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.143086 21251 ts_manager.cc:194] Registered new tserver with Master: c8f60378aaea427e9e630bc072fd339d (127.20.146.67:32971)
18:18:38.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144145 21748 heartbeater.cc:344] Connected to a master server at 127.20.146.125:35285
18:18:38.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144147 21251 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.146.67:57467
18:18:38.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144280 21748 heartbeater.cc:461] Registering TS with master...
18:18:38.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144548 21748 heartbeater.cc:507] Master 127.20.146.125:35285 requested a full tablet report, sending...
18:18:38.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144811 21747 heartbeater.cc:344] Connected to a master server at 127.20.146.126:39103
18:18:38.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.144883 21747 heartbeater.cc:461] Registering TS with master...
18:18:38.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.145066 21747 heartbeater.cc:507] Master 127.20.146.126:39103 requested a full tablet report, sending...
18:18:38.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.145367 21179 ts_manager.cc:194] Registered new tserver with Master: c8f60378aaea427e9e630bc072fd339d (127.20.146.67:32971)
18:18:38.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.145835 21106 ts_manager.cc:194] Registered new tserver with Master: c8f60378aaea427e9e630bc072fd339d (127.20.146.67:32971)
18:18:38.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.152642 21065 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:18:38.154 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:18:38.155 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:18:38.164 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.146.126"
      port: 39103
    }
    bound_http_address {
      host: "127.20.146.126"
      port: 39551
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.20.146.125"
      port: 35285
    }
    bound_http_address {
      host: "127.20.146.125"
      port: 39295
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.20.146.124"
      port: 39985
    }
    bound_http_address {
      host: "127.20.146.124"
      port: 41631
    }
  }
}

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

18:18:38.170 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.146.65"
      port: 36189
    }
    bound_http_address {
      host: "127.20.146.65"
      port: 33303
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.20.146.66"
      port: 40535
    }
    bound_http_address {
      host: "127.20.146.66"
      port: 33165
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.20.146.67"
      port: 32971
    }
    bound_http_address {
      host: "127.20.146.67"
      port: 45987
    }
  }
}

18:18:38.170 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:18:38.342 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
18:18:38.392 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:18:38.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.415484 21321 catalog_manager.cc:1294] Loaded cluster ID: b1e2c697c701417181fc8f5e77b00d43
18:18:38.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.415581 21321 catalog_manager.cc:1587] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: loading cluster ID for follower catalog manager: success
18:18:38.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.417976 21321 catalog_manager.cc:1609] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: acquiring CA information for follower catalog manager: success
18:18:38.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.419377 21321 catalog_manager.cc:1637] T 00000000000000000000000000000000 P bf8d018b4698406590df3233d57ee28b: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:18:38.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.431634 21338 catalog_manager.cc:1294] Loaded cluster ID: b1e2c697c701417181fc8f5e77b00d43
18:18:38.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.431715 21338 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: loading cluster ID for follower catalog manager: success
18:18:38.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.434080 21338 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: acquiring CA information for follower catalog manager: success
18:18:38.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.435485 21338 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 66561ca5218745889d3b9e96f522335a: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:18:38.552 [DEBUG - main] (Connection.java:748) [peer master-127.20.146.125:35285(127.20.146.125:35285)] connecting to peer
18:18:38.608 [DEBUG - main] (Connection.java:748) [peer master-127.20.146.126:39103(127.20.146.126:39103)] connecting to peer
18:18:38.616 [DEBUG - main] (Connection.java:748) [peer master-127.20.146.124:39985(127.20.146.124:39985)] connecting to peer
18:18:38.627 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.20.146.125:35285(127.20.146.125:35285)] Successfully connected to peer
18:18:38.628 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.20.146.124:39985(127.20.146.124:39985)] Successfully connected to peer
18:18:38.631 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.20.146.126:39103(127.20.146.126:39103)] Successfully connected to peer
18:18:38.732 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.146.125
18:18:38.732 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.146.124
18:18:38.732 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.146.126
18:18:38.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.762737 21476 heartbeater.cc:499] Master 127.20.146.124:39985 was elected leader, sending a full tablet report...
18:18:38.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:38.956041 21611 heartbeater.cc:499] Master 127.20.146.124:39985 was elected leader, sending a full tablet report...
18:18:38.988 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xbbda0d48, L:/127.0.0.1:39242 - R:/127.20.146.125:35285] using SASL/PLAIN
18:18:38.988 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x064faa00, L:/127.0.0.1:46390 - R:/127.20.146.124:39985] using SASL/PLAIN
18:18:38.988 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x8bbc650e, L:/127.0.0.1:42314 - R:/127.20.146.126:39103] using SASL/PLAIN
18:18:39.028 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:18:39.029 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=515), Traces: [0ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.146.125:35285, [90ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.146.126:39103, [97ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.146.124:39985, [484ms] Sub RPC ConnectToMaster: received response from server master-127.20.146.126:39103: OK, [484ms] Sub RPC ConnectToMaster: received response from server master-127.20.146.125:35285: OK, [486ms] Sub RPC ConnectToMaster: received response from server master-127.20.146.124:39985: OK, deferred=null) after lookup
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.080868 21251 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:46390:
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestStatistics-1783534715593"
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:18:39.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:18:39.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:18:39.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:18:39.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:18:39.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.107749 21680 tablet_service.cc:1511] Processing CreateTablet for tablet 85420ff4547d41af90649a2674924b88 (DEFAULT_TABLE table=org.apache.kudu.client.TestStatistics-1783534715593 [id=aa0f0fbe10d04db6a4afd06e0e079357]), partition=RANGE (key) PARTITION UNBOUNDED
18:18:39.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.109287 21680 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 85420ff4547d41af90649a2674924b88. 1 dirs total, 0 dirs full, 0 dirs failed
18:18:39.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.118894 21770 tablet_bootstrap.cc:492] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: Bootstrap starting.
18:18:39.120 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table aa0f0fbe10d04db6a4afd06e0e079357
18:18:39.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.122238 21770 tablet_bootstrap.cc:654] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: Neither blocks nor log segments found. Creating new log.
18:18:39.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.123206 21770 log.cc:826] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: Log is configured to *not* fsync() on all Append() calls
18:18:39.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.125193 21770 tablet_bootstrap.cc:492] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: No bootstrap required, opened a new log
18:18:39.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.125408 21770 ts_tablet_manager.cc:1403] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: Time spent bootstrapping tablet: real 0.007s	user 0.004s	sys 0.000s
18:18:39.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.128990 21770 raft_consensus.cc:359] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c8f60378aaea427e9e630bc072fd339d" member_type: VOTER last_known_addr { host: "127.20.146.67" port: 32971 } }
18:18:39.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.129225 21770 raft_consensus.cc:385] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:18:39.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.129276 21770 raft_consensus.cc:740] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c8f60378aaea427e9e630bc072fd339d, State: Initialized, Role: FOLLOWER
18:18:39.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.129779 21770 consensus_queue.cc:260] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [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: "c8f60378aaea427e9e630bc072fd339d" member_type: VOTER last_known_addr { host: "127.20.146.67" port: 32971 } }
18:18:39.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.129928 21770 raft_consensus.cc:399] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
18:18:39.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.129982 21770 raft_consensus.cc:493] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
18:18:39.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.130060 21770 raft_consensus.cc:3060] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 0 FOLLOWER]: Advancing to term 1
18:18:39.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.131063 21770 raft_consensus.cc:515] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c8f60378aaea427e9e630bc072fd339d" member_type: VOTER last_known_addr { host: "127.20.146.67" port: 32971 } }
18:18:39.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.131449 21770 leader_election.cc:304] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [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: c8f60378aaea427e9e630bc072fd339d; no voters: 
18:18:39.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.131765 21770 leader_election.cc:290] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [CANDIDATE]: Term 1 election: Requested vote from peers 
18:18:39.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.131870 21772 raft_consensus.cc:2804] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 1 FOLLOWER]: Leader election won for term 1
18:18:39.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.132344 21772 raft_consensus.cc:697] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [term 1 LEADER]: Becoming Leader. State: Replica: c8f60378aaea427e9e630bc072fd339d, State: Running, Role: LEADER
18:18:39.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.132792 21770 ts_tablet_manager.cc:1434] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d: Time spent starting tablet: real 0.007s	user 0.008s	sys 0.000s
18:18:39.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.132751 21772 consensus_queue.cc:237] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d [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: "c8f60378aaea427e9e630bc072fd339d" member_type: VOTER last_known_addr { host: "127.20.146.67" port: 32971 } }
18:18:39.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.133330 21746 heartbeater.cc:499] Master 127.20.146.124:39985 was elected leader, sending a full tablet report...
18:18:39.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.139621 21251 catalog_manager.cc:5696] T 85420ff4547d41af90649a2674924b88 P c8f60378aaea427e9e630bc072fd339d reported cstate change: term changed from 0 to 1, leader changed from <none> to c8f60378aaea427e9e630bc072fd339d (127.20.146.67). New cstate: current_term: 1 leader_uuid: "c8f60378aaea427e9e630bc072fd339d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c8f60378aaea427e9e630bc072fd339d" member_type: VOTER last_known_addr { host: "127.20.146.67" port: 32971 } health_report { overall_health: HEALTHY } } }
18:18:39.175 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 85420ff4547d41af90649a2674924b88 for table 'org.apache.kudu.client.TestStatistics-1783534715593' with partition [<start>, <end>)
18:18:39.175 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@875061767(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.181 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=85420ff4547d41af90649a2674924b88@[c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)[L]]}]
18:18:39.184 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet 85420ff4547d41af90649a2674924b88 for table 'org.apache.kudu.client.TestStatistics-1783534715593' with partition [<start>, <end>)
18:18:39.184 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=85420ff4547d41af90649a2674924b88@[c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)[L]]}]
18:18:39.206 [DEBUG - kudu-nio-2] (Connection.java:748) [peer c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)] connecting to peer
18:18:39.211 [DEBUG - kudu-nio-3] (Connection.java:757) [peer c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)] Successfully connected to peer
18:18:39.276 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x2acc5fb3, L:/127.0.0.1:37622 - R:/127.20.146.67:32971] using TOKEN/null
18:18:39.312 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@217400679(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.319 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@2075797156(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.325 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@767474923(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.333 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@50445618(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.338 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@628690504(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.344 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@257721157(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.350 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1465724833(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.355 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1497100373(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.361 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@886947444(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:18:39.468 [DEBUG - main] (Connection.java:575) [peer master-127.20.146.125:35285(127.20.146.125:35285)] disconnecting while in state READY
18:18:39.469 [DEBUG - main] (Connection.java:575) [peer master-127.20.146.126:39103(127.20.146.126:39103)] disconnecting while in state READY
18:18:39.470 [DEBUG - main] (Connection.java:575) [peer master-127.20.146.124:39985(127.20.146.124:39985)] disconnecting while in state READY
18:18:39.470 [DEBUG - main] (Connection.java:575) [peer c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)] disconnecting while in state READY
18:18:39.474 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:18:39.474 [DEBUG - kudu-nio-3] (Connection.java:239) [peer c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)] handling channelInactive
18:18:39.474 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.20.146.124:39985(127.20.146.124:39985)] handling channelInactive
18:18:39.475 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.20.146.126:39103(127.20.146.126:39103)] handling channelInactive
18:18:39.475 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.20.146.124:39985(127.20.146.124:39985)] cleaning up while in state READY due to: connection closed
18:18:39.476 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.20.146.126:39103(127.20.146.126:39103)] cleaning up while in state READY due to: connection closed
18:18:39.478 [DEBUG - kudu-nio-3] (Connection.java:709) [peer c8f60378aaea427e9e630bc072fd339d(127.20.146.67:32971)] cleaning up while in state READY due to: connection closed
18:18:39.479 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.20.146.125:35285(127.20.146.125:35285)] handling channelInactive
18:18:39.480 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.20.146.125:35285(127.20.146.125:35285)] cleaning up while in state READY due to: connection closed
18:18:39.481 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.481135 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21348
18:18:39.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.487308 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21483
18:18:39.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.493191 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21618
18:18:39.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.500638 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21076
18:18:39.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.507541 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21145
18:18:39.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:18:39.515923 21065 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskSP9Aay/build/debug/bin/kudu with pid 21217
18:18:39.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:18:39Z chronyd exiting

Time: 3.754

OK (1 test)

