JUnit version 4.13.2
.18:21:24.549 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783534884540
18:21:24.574 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:21:24.611 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:21:24.619 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task1tUVpC/test-tmp
18:21:24.646 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
18:21:24.649 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task1tUVpC/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
18:21:24.849 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:21:24.865 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:21:24.867 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:21:24.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.868069  1548 mini_oidc.cc:150] Starting JWKS server
18:21:24.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.868809  1548 webserver.cc:534] Webserver started at http://127.0.0.1:35231/ using document root <none> and password file <none>
18:21:24.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.868911  1548 mini_oidc.cc:186] Starting OIDC Discovery server
18:21:24.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.869083  1548 webserver.cc:534] Webserver started at http://127.0.0.1:45001/ using document root <none> and password file <none>
18:21:24.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:21:24Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:21:24.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:21:24Z Disabled control of system clock
18:21:24.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.882560  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:24.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:24.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal
18:21:24.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data
18:21:24.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:24.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:24.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:24.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:24.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:24.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:24.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/logs
18:21:24.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data/info.pb
18:21:24.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:24.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:24.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:24.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:24.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:24.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:24.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:24.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:24.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:24.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.62:33909
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.62
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:24.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:24.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:24.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:24.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:24.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json with env {}
18:21:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.963147  1559 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.963343  1559 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:24.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.963364  1559 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:24.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965409  1559 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965477  1559 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965492  1559 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965505  1559 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:24.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965518  1559 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:24.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.965530  1559 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35231/jwks.json
18:21:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.967789  1559 master_runner.cc:387] Master server non-default flags:
18:21:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:24.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:24.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data
18:21:24.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal
18:21:24.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:24.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:24.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:24.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:24.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:24.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.62:33909
18:21:24.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:24.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:24.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:24.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json
18:21:24.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:24.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:24.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data/info.pb
18:21:24.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.62
18:21:24.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:24.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:24.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1559
18:21:24.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:24.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:24.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:24.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:24.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/logs
18:21:24.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:24.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:24.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:24.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:24.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.968075  1559 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:21:24.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.968338  1559 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:24.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.971132  1564 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:21:24.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.971158  1565 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:21:24.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:24.971238  1567 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:21:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.971427  1559 server_base.cc:1061] running on GCE node
18:21:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.971645  1559 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.971915  1559 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.973081  1559 hybrid_clock.cc:648] HybridClock initialized: now 1783534884973042 us; error 56 us; skew 500 ppm
18:21:24.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.974416  1559 webserver.cc:534] Webserver started at http://127.1.131.62:42659/ using document root <none> and password file <none>
18:21:24.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.974565  1559 fs_manager.cc:362] Metadata directory not provided
18:21:24.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.974598  1559 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:24.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.974674  1559 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:24.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.975682  1559 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data/instance:
18:21:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "35e16b512ae64a238253afe1fb0ceb92"
18:21:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:24 on dist-test-slave-7p5s"
18:21:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.975942  1559 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal/instance:
18:21:24.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "35e16b512ae64a238253afe1fb0ceb92"
18:21:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:24 on dist-test-slave-7p5s"
18:21:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.977147  1559 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
18:21:24.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.978053  1573 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.978240  1559 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:21:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.978298  1559 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal
18:21:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "35e16b512ae64a238253afe1fb0ceb92"
18:21:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:24 on dist-test-slave-7p5s"
18:21:24.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:24.978346  1559 fs_report.cc:389] FS layout report
18:21:24.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:24.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal
18:21:24.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal
18:21:24.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data/data
18:21:24.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:24.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:24.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:24.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:24.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.007342  1559 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.007772  1559 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:21:25.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.007905  1559 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.012797  1559 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.62:33909
18:21:25.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.012847  1625 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.62:33909 every 8 connection(s)
18:21:25.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.013247  1559 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/data/info.pb
18:21:25.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.013959  1626 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:21:25.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.015637  1626 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.018851  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 1559
18:21:25.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.018968  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-0/wal/instance
18:21:25.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.019937  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal
18:21:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data
18:21:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:25.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:25.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/logs
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data/info.pb
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:25.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.61:35297
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.61
18:21:25.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:25.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json with env {}
18:21:25.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.027436  1626 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.027932  1577 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.1.131.61:35297: connect: Connection refused (error 111)
18:21:25.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.028450  1626 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.61:35297: Network error: Client connection negotiation failed: client connection to 127.1.131.61:35297: connect: Connection refused (error 111)
18:21:25.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.077662  1626 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } attempt: 1
18:21:25.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.079010  1626 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.61:35297: Network error: Client connection negotiation failed: client connection to 127.1.131.61:35297: connect: Connection refused (error 111)
18:21:25.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.102741  1630 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:25.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.102937  1630 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:25.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.102958  1630 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:25.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104661  1630 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:25.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104718  1630 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:25.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104733  1630 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104746  1630 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104760  1630 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:25.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.104771  1630 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35231/jwks.json
18:21:25.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.107146  1630 master_runner.cc:387] Master server non-default flags:
18:21:25.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:25.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:25.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.61:35297
18:21:25.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:25.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:25.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:25.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json
18:21:25.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data/info.pb
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.61
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1630
18:21:25.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/logs
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:25.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:25.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.107455  1630 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:21:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.107779  1630 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.110981  1639 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:21:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.110949  1637 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:21:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.111227  1636 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:21:25.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.111752  1630 server_base.cc:1061] running on GCE node
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.111994  1630 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.112274  1630 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.113404  1630 hybrid_clock.cc:648] HybridClock initialized: now 1783534885113381 us; error 36 us; skew 500 ppm
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.114804  1630 webserver.cc:534] Webserver started at http://127.1.131.61:43597/ using document root <none> and password file <none>
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.115022  1630 fs_manager.cc:362] Metadata directory not provided
18:21:25.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.115078  1630 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:25.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.115182  1630 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:25.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.116338  1630 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data/instance:
18:21:25.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "103b6b1855f24a7b840b15db5e9834c9"
18:21:25.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.116724  1630 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal/instance:
18:21:25.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "103b6b1855f24a7b840b15db5e9834c9"
18:21:25.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.118388  1630 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
18:21:25.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.119287  1645 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:25.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.119884  1630 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:25.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.120038  1630 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal
18:21:25.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "103b6b1855f24a7b840b15db5e9834c9"
18:21:25.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.120110  1630 fs_report.cc:389] FS layout report
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data/data
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:25.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:25.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:25.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:25.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:25.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:25.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:25.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:25.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:25.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:25.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.133800  1630 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.134770  1630 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:21:25.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.135334  1630 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.140293  1630 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.61:35297
18:21:25.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.140341  1697 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.61:35297 every 8 connection(s)
18:21:25.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.141207  1630 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/data/info.pb
18:21:25.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.141487  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 1630
18:21:25.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.141561  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-1/wal/instance
18:21:25.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.141981  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal
18:21:25.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/logs
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data/info.pb
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:25.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:25.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.60:34503
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.60
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json with env {}
18:21:25.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.147249  1626 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } attempt: 2
18:21:25.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.148864  1699 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:21:25.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.151856  1699 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.155766  1626 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.156313  1626 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.60:34503: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.156356  1699 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.160020  1699 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.160879  1649 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.161684  1699 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.60:34503: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.199491  1626 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } attempt: 1
18:21:25.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.200484  1626 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.60:34503: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.210915  1699 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } attempt: 1
18:21:25.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.211797  1699 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.60:34503: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.233628  1698 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.234254  1698 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:25.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.234287  1698 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:25.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236639  1698 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:25.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236712  1698 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:25.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236727  1698 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:25.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236740  1698 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:25.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236753  1698 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:25.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.236764  1698 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:35231/jwks.json
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.238801  1698 master_runner.cc:387] Master server non-default flags:
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.60:34503
18:21:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:25.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35231/jwks.json
18:21:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data/info.pb
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.60
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1698
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/logs
18:21:25.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:25.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.239049  1698 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:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.239251  1698 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.243062  1708 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:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.243247  1709 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:21:25.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.243373  1698 server_base.cc:1061] running on GCE node
18:21:25.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.244021  1711 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:21:25.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.244313  1698 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:25.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.244663  1698 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:25.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.245850  1698 hybrid_clock.cc:648] HybridClock initialized: now 1783534885245818 us; error 47 us; skew 500 ppm
18:21:25.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.247283  1698 webserver.cc:534] Webserver started at http://127.1.131.60:34741/ using document root <none> and password file <none>
18:21:25.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.247529  1698 fs_manager.cc:362] Metadata directory not provided
18:21:25.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.247589  1698 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:25.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.247728  1698 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:25.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.248245  1626 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } attempt: 2
18:21:25.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.248893  1626 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.1.131.60:34503: Network error: Client connection negotiation failed: client connection to 127.1.131.60:34503: connect: Connection refused (error 111)
18:21:25.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.248857  1698 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data/instance:
18:21:25.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a75b5b853c2447cbb0653f24e9461d04"
18:21:25.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.249258  1698 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal/instance:
18:21:25.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a75b5b853c2447cbb0653f24e9461d04"
18:21:25.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.250905  1698 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.251744  1717 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.251998  1698 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.252065  1698 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a75b5b853c2447cbb0653f24e9461d04"
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.252123  1698 fs_report.cc:389] FS layout report
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:25.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data/data
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:25.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:25.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:25.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:25.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:25.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.268661  1698 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.269084  1698 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:21:25.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.269217  1698 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.273614  1698 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.60:34503
18:21:25.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.273645  1769 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.60:34503 every 8 connection(s)
18:21:25.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.274060  1698 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/data/info.pb
18:21:25.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.274711  1770 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:21:25.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.276057  1770 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.278258  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 1698
18:21:25.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.278404  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/master-2/wal/instance
18:21:25.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.279961  1699 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } attempt: 2
18:21:25.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.282485  1770 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.286916  1699 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: Bootstrap starting.
18:21:25.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.287657  1699 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: Neither blocks nor log segments found. Creating new log.
18:21:25.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.287943  1699 log.cc:826] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: Log is configured to *not* fsync() on all Append() calls
18:21:25.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.288578  1770 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } has no permanent_uuid. Determining permanent_uuid...
18:21:25.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.289022  1699 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: No bootstrap required, opened a new log
18:21:25.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.291024  1699 raft_consensus.cc:359] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.291457  1699 raft_consensus.cc:385] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:25.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.291501  1699 raft_consensus.cc:740] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 103b6b1855f24a7b840b15db5e9834c9, State: Initialized, Role: FOLLOWER
18:21:25.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.291617  1699 consensus_queue.cc:260] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.292315  1699 sys_catalog.cc:565] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: configured and running, proceeding with master startup.
18:21:25.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.294140  1770 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: Bootstrap starting.
18:21:25.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.294827  1770 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: Neither blocks nor log segments found. Creating new log.
18:21:25.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.295408  1770 log.cc:826] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: Log is configured to *not* fsync() on all Append() calls
18:21:25.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.294548  1780 sys_catalog.cc:455] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.295222  1791 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:25.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.296279  1770 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: No bootstrap required, opened a new log
18:21:25.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.296289  1780 sys_catalog.cc:458] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.296298  1791 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:25.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.297947  1770 raft_consensus.cc:359] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.298086  1770 raft_consensus.cc:385] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:25.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.296316  1630 master_runner.cc:187] Error getting master registration for 127.1.131.62:33909: OK, instance_id { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" instance_seqno: 1783534885011390 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.298128  1770 raft_consensus.cc:740] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a75b5b853c2447cbb0653f24e9461d04, State: Initialized, Role: FOLLOWER
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.298182  1630 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.298216  1770 consensus_queue.cc:260] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.298517  1770 sys_catalog.cc:565] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: configured and running, proceeding with master startup.
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.299095  1794 sys_catalog.cc:455] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.299185  1794 sys_catalog.cc:458] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.300546  1805 catalog_manager.cc:1593] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:25.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.300843  1805 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.301720  1698 master_runner.cc:187] Error getting master registration for 127.1.131.62:33909: OK, instance_id { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" instance_seqno: 1783534885011390 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:21:25.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.303493  1698 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:21:25.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.346776  1794 raft_consensus.cc:493] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:21:25.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.346925  1794 raft_consensus.cc:515] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.347198  1794 leader_election.cc:290] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 35e16b512ae64a238253afe1fb0ceb92 (127.1.131.62:33909), 103b6b1855f24a7b840b15db5e9834c9 (127.1.131.61:35297)
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.347882  1672 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a75b5b853c2447cbb0653f24e9461d04" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "103b6b1855f24a7b840b15db5e9834c9" is_pre_election: true
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.348042  1672 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a75b5b853c2447cbb0653f24e9461d04 in term 0.
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.348266  1721 leader_election.cc:304] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [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: 103b6b1855f24a7b840b15db5e9834c9, a75b5b853c2447cbb0653f24e9461d04; no voters: 
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.348398  1794 raft_consensus.cc:2804] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.348440  1794 raft_consensus.cc:493] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:21:25.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.348462  1794 raft_consensus.cc:3060] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 0 FOLLOWER]: Advancing to term 1
18:21:25.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.349673  1794 raft_consensus.cc:515] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.349817  1794 leader_election.cc:290] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [CANDIDATE]: Term 1 election: Requested vote from peers 35e16b512ae64a238253afe1fb0ceb92 (127.1.131.62:33909), 103b6b1855f24a7b840b15db5e9834c9 (127.1.131.61:35297)
18:21:25.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.350102  1672 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a75b5b853c2447cbb0653f24e9461d04" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "103b6b1855f24a7b840b15db5e9834c9"
18:21:25.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.350171  1672 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 0 FOLLOWER]: Advancing to term 1
18:21:25.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.350962  1672 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a75b5b853c2447cbb0653f24e9461d04 in term 1.
18:21:25.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351138  1721 leader_election.cc:304] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [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: 103b6b1855f24a7b840b15db5e9834c9, a75b5b853c2447cbb0653f24e9461d04; no voters: 
18:21:25.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351213  1794 raft_consensus.cc:2804] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 1 FOLLOWER]: Leader election won for term 1
18:21:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351356  1794 raft_consensus.cc:697] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [term 1 LEADER]: Becoming Leader. State: Replica: a75b5b853c2447cbb0653f24e9461d04, State: Running, Role: LEADER
18:21:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351433  1794 consensus_queue.cc:237] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351776  1794 sys_catalog.cc:455] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a75b5b853c2447cbb0653f24e9461d04. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.351833  1794 sys_catalog.cc:458] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: This master's current role is: LEADER
18:21:25.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.352093  1809 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
18:21:25.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.352267  1809 catalog_manager.cc:1519] Initializing Kudu cluster ID...
18:21:25.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.354133  1672 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [term 1 FOLLOWER]: Refusing update from remote peer a75b5b853c2447cbb0653f24e9461d04: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:25.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.354400  1807 consensus_queue.cc:1048] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [LEADER]: Connected to new peer: Peer: permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.355618  1780 sys_catalog.cc:455] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a75b5b853c2447cbb0653f24e9461d04. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.356014  1626 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } attempt: 3
18:21:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.356612  1807 sys_catalog.cc:455] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.356694  1807 sys_catalog.cc:458] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: This master's current role is: LEADER
18:21:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.357375  1810 mvcc.cc:204] Tried to move back new op lower bound from 7305358890408079360 to 7305358890400014336. Current Snapshot: MvccSnapshot[applied={T|T < 7305358890408079360}]
18:21:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.360586  1626 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: Bootstrap starting.
18:21:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.361367  1626 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: Neither blocks nor log segments found. Creating new log.
18:21:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.361965  1626 log.cc:826] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: Log is configured to *not* fsync() on all Append() calls
18:21:25.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.366495  1809 catalog_manager.cc:1382] Generated new cluster ID: 85bcdc8b06584153a4344f3a80cb48e2
18:21:25.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.366570  1809 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
18:21:25.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.357477  1811 mvcc.cc:204] Tried to move back new op lower bound from 7305358890408079360 to 7305358890400014336. Current Snapshot: MvccSnapshot[applied={T|T < 7305358890408079360}]
18:21:25.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.374368  1780 sys_catalog.cc:458] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.377579  1626 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: No bootstrap required, opened a new log
18:21:25.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.379328  1626 raft_consensus.cc:359] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.379494  1626 raft_consensus.cc:385] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:25.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.379528  1626 raft_consensus.cc:740] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 35e16b512ae64a238253afe1fb0ceb92, State: Initialized, Role: FOLLOWER
18:21:25.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.379674  1626 consensus_queue.cc:260] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } }
18:21:25.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.380021  1626 sys_catalog.cc:565] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: configured and running, proceeding with master startup.
18:21:25.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.380062  1600 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a75b5b853c2447cbb0653f24e9461d04" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "35e16b512ae64a238253afe1fb0ceb92" is_pre_election: true
18:21:25.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.380205  1600 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate a75b5b853c2447cbb0653f24e9461d04 in term 0.
18:21:25.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.380532  1598 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 0 FOLLOWER]: Advancing to term 1
18:21:25.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.381481  1598 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 1 FOLLOWER]: Refusing update from remote peer a75b5b853c2447cbb0653f24e9461d04: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:25.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.381948  1794 consensus_queue.cc:1048] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [LEADER]: Connected to new peer: Peer: permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.382191  1599 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "a75b5b853c2447cbb0653f24e9461d04" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "35e16b512ae64a238253afe1fb0ceb92"
18:21:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.381696  1817 sys_catalog.cc:455] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [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: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.382720  1817 sys_catalog.cc:458] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.383023  1599 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate a75b5b853c2447cbb0653f24e9461d04 in term 1.
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.392146  1814 sys_catalog.cc:455] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.392253  1814 sys_catalog.cc:458] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.394054  1817 sys_catalog.cc:455] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: SysCatalogTable state changed. Reason: New leader a75b5b853c2447cbb0653f24e9461d04. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.394171  1817 sys_catalog.cc:458] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.394212  1817 sys_catalog.cc:455] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.394248  1817 sys_catalog.cc:458] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92 [sys.catalog]: This master's current role is: FOLLOWER
18:21:25.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.397568  1809 catalog_manager.cc:1405] Generated new certificate authority record
18:21:25.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.398259  1809 catalog_manager.cc:1539] Loading token signing keys...
18:21:25.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.400002  1828 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:25.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.400069  1828 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:25.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.401326  1807 sys_catalog.cc:455] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "a75b5b853c2447cbb0653f24e9461d04" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "35e16b512ae64a238253afe1fb0ceb92" member_type: VOTER last_known_addr { host: "127.1.131.62" port: 33909 } } peers { permanent_uuid: "103b6b1855f24a7b840b15db5e9834c9" member_type: VOTER last_known_addr { host: "127.1.131.61" port: 35297 } } peers { permanent_uuid: "a75b5b853c2447cbb0653f24e9461d04" member_type: VOTER last_known_addr { host: "127.1.131.60" port: 34503 } } }
18:21:25.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.401429  1807 sys_catalog.cc:458] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04 [sys.catalog]: This master's current role is: LEADER
18:21:25.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.402524  1829 mvcc.cc:204] Tried to move back new op lower bound from 7305358890408079360 to 7305358890400014336. Current Snapshot: MvccSnapshot[applied={T|T < 7305358890408079360}]
18:21:25.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.423153  1809 catalog_manager.cc:6069] T 00000000000000000000000000000000 P a75b5b853c2447cbb0653f24e9461d04: Generated new TSK 0
18:21:25.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.423832  1809 catalog_manager.cc:1549] Initializing in-progress tserver states...
18:21:25.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.438102  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/logs
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data/info.pb
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.1:0
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.1
18:21:25.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.1
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:25.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.555429  1836 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:25.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.555634  1836 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:25.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.555656  1836 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:25.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.557600  1836 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:25.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.557672  1836 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.131.1
18:21:25.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.564296  1836 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.1:0
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data/info.pb
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.1
18:21:25.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1836
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.1
18:21:25.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/logs
18:21:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:25.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:25.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:25.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:25.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.564656  1836 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:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.564952  1836 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.567795  1844 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:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.568979  1842 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:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.569207  1841 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:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.569774  1836 server_base.cc:1061] running on GCE node
18:21:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.570051  1836 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:25.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.570331  1836 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:25.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.571503  1836 hybrid_clock.cc:648] HybridClock initialized: now 1783534885571481 us; error 36 us; skew 500 ppm
18:21:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.572961  1836 webserver.cc:534] Webserver started at http://127.1.131.1:43241/ using document root <none> and password file <none>
18:21:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.573184  1836 fs_manager.cc:362] Metadata directory not provided
18:21:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.573256  1836 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:25.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.573406  1836 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:25.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.574627  1836 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data/instance:
18:21:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d7864f4c377247f5a8c813e23678b1a8"
18:21:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.575019  1836 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal/instance:
18:21:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d7864f4c377247f5a8c813e23678b1a8"
18:21:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.576625  1836 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
18:21:25.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.577543  1850 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.577975  1836 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.578056  1836 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d7864f4c377247f5a8c813e23678b1a8"
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.578121  1836 fs_report.cc:389] FS layout report
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data/data
18:21:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:25.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.639423  1836 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.639726  1836 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:21:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.639814  1836 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.640017  1836 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.640309  1836 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:25.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.640332  1836 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.640355  1836 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:25.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.640368  1836 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:25.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.646596  1836 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.1:38845
18:21:25.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.646670  1963 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.1:38845 every 8 connection(s)
18:21:25.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.647013  1836 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/data/info.pb
18:21:25.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.650897  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 1836
18:21:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.651005  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-0/wal/instance
18:21:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.652457  1965 heartbeater.cc:344] Connected to a master server at 127.1.131.62:33909
18:21:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.652463  1964 heartbeater.cc:344] Connected to a master server at 127.1.131.60:34503
18:21:25.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.652593  1964 heartbeater.cc:461] Registering TS with master...
18:21:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.652596  1965 heartbeater.cc:461] Registering TS with master...
18:21:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.652818  1965 heartbeater.cc:507] Master 127.1.131.62:33909 requested a full tablet report, sending...
18:21:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.653136  1964 heartbeater.cc:507] Master 127.1.131.60:34503 requested a full tablet report, sending...
18:21:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.653221  1590 ts_manager.cc:194] Registered new tserver with Master: d7864f4c377247f5a8c813e23678b1a8 (127.1.131.1:38845)
18:21:25.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.653548  1734 ts_manager.cc:194] Registered new tserver with Master: d7864f4c377247f5a8c813e23678b1a8 (127.1.131.1:38845)
18:21:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654297  1966 heartbeater.cc:344] Connected to a master server at 127.1.131.61:35297
18:21:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654383  1966 heartbeater.cc:461] Registering TS with master...
18:21:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654434  1734 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.1.131.1:51219
18:21:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654484  1966 heartbeater.cc:507] Master 127.1.131.61:35297 requested a full tablet report, sending...
18:21:25.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654860  1654 ts_manager.cc:194] Registered new tserver with Master: d7864f4c377247f5a8c813e23678b1a8 (127.1.131.1:38845)
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.654963  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/logs
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data/info.pb
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:25.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.2:0
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.2
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.2
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.733285  1971 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.733500  1971 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.733522  1971 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.734989  1971 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:25.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.735044  1971 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.131.2
18:21:25.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.736559  1971 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:25.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.2:0
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data/info.pb
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.2
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.1971
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.2
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/logs
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.736763  1971 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:21:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.736965  1971 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:25.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.739498  1977 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:21:25.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.739506  1976 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:21:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.739537  1979 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:21:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.740298  1971 server_base.cc:1061] running on GCE node
18:21:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.740469  1971 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.740635  1971 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:25.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.741788  1971 hybrid_clock.cc:648] HybridClock initialized: now 1783534885741766 us; error 43 us; skew 500 ppm
18:21:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.743163  1971 webserver.cc:534] Webserver started at http://127.1.131.2:38883/ using document root <none> and password file <none>
18:21:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.743366  1971 fs_manager.cc:362] Metadata directory not provided
18:21:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.743424  1971 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:25.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.743523  1971 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.744587  1971 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data/instance:
18:21:25.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f813e278458e4abea584fd8d06496ced"
18:21:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.744851  1971 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal/instance:
18:21:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f813e278458e4abea584fd8d06496ced"
18:21:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.746282  1971 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.747115  1985 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.747328  1971 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.747395  1971 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f813e278458e4abea584fd8d06496ced"
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.747452  1971 fs_report.cc:389] FS layout report
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal
18:21:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data/data
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.767732  1971 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768011  1971 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:21:25.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768096  1971 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768390  1971 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:25.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768790  1971 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:25.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768828  1971 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:25.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768862  1971 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:25.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.768885  1971 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:25.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.776870  1971 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.2:42231
18:21:25.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.776908  2098 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.2:42231 every 8 connection(s)
18:21:25.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.777792  1971 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/data/info.pb
18:21:25.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.779867  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 1971
18:21:25.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.779959  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-1/wal/instance
18:21:25.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.781782  1548 external_mini_cluster.cc:1372] Running /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task1tUVpC/build/release/bin/kudu
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/logs
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data/info.pb
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:25.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.3:0
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.3
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.3
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.784354  2099 heartbeater.cc:344] Connected to a master server at 127.1.131.60:34503
18:21:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.784461  2099 heartbeater.cc:461] Registering TS with master...
18:21:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.784672  2099 heartbeater.cc:507] Master 127.1.131.60:34503 requested a full tablet report, sending...
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.785368  1734 ts_manager.cc:194] Registered new tserver with Master: f813e278458e4abea584fd8d06496ced (127.1.131.2:42231)
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.785883  1734 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.1.131.2:46749
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.786000  2101 heartbeater.cc:344] Connected to a master server at 127.1.131.61:35297
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.786044  2101 heartbeater.cc:461] Registering TS with master...
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.786166  2101 heartbeater.cc:507] Master 127.1.131.61:35297 requested a full tablet report, sending...
18:21:25.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.786484  1654 ts_manager.cc:194] Registered new tserver with Master: f813e278458e4abea584fd8d06496ced (127.1.131.2:42231)
18:21:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.787992  2100 heartbeater.cc:344] Connected to a master server at 127.1.131.62:33909
18:21:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.788058  2100 heartbeater.cc:461] Registering TS with master...
18:21:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.788102  2100 heartbeater.cc:507] Master 127.1.131.62:33909 requested a full tablet report, sending...
18:21:25.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.788403  1590 ts_manager.cc:194] Registered new tserver with Master: f813e278458e4abea584fd8d06496ced (127.1.131.2:42231)
18:21:25.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.862593  2105 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:25.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.862795  2105 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:25.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.862825  2105 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:25.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.864535  2105 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:25.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.864629  2105 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.1.131.3
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.866348  2105 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.1.131.20:33273
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data
18:21:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.1.131.3:0
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data/info.pb
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.1.131.3
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.1.131.62:33909,127.1.131.61:35297,127.1.131.60:34503
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2105
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.1.131.3
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/logs
18:21:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:01:16 UTC on e7f111948823
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16869
18:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.866633  2105 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:21:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.866918  2105 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.870059  2113 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:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.870095  2110 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:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:25.870090  2111 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:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.870226  2105 server_base.cc:1061] running on GCE node
18:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.870633  2105 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.870838  2105 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:25.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.871989  2105 hybrid_clock.cc:648] HybridClock initialized: now 1783534885871967 us; error 45 us; skew 500 ppm
18:21:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.873055  2105 webserver.cc:534] Webserver started at http://127.1.131.3:35993/ using document root <none> and password file <none>
18:21:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.873206  2105 fs_manager.cc:362] Metadata directory not provided
18:21:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.873245  2105 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.873376  2105 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.874445  2105 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data/instance:
18:21:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "595a409171c4467e9be468c4542cfd60"
18:21:25.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.875119  2105 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal/instance:
18:21:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "595a409171c4467e9be468c4542cfd60"
18:21:25.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.876242  2105 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
18:21:25.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.877010  2119 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:25.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.877481  2105 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:25.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.877636  2105 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data,/tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal
18:21:25.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "595a409171c4467e9be468c4542cfd60"
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:21:25 on dist-test-slave-7p5s"
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.877730  2105 fs_report.cc:389] FS layout report
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data/data
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:25.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:25.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:25.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:25.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:25.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.891541  2105 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:25.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.891940  2105 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:21:25.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892107  2105 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:25.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892383  2105 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:25.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892781  2105 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:25.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892853  2105 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:25.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892887  2105 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:25.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.892904  2105 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.898892  2105 rpc_server.cc:307] RPC server started. Bound to: 127.1.131.3:38555
18:21:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.899022  2232 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.1.131.3:38555 every 8 connection(s)
18:21:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.899358  2105 server_base.cc:1193] Dumped server information to /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/data/info.pb
18:21:25.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.904657  2234 heartbeater.cc:344] Connected to a master server at 127.1.131.62:33909
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.904784  2234 heartbeater.cc:461] Registering TS with master...
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.904949  2233 heartbeater.cc:344] Connected to a master server at 127.1.131.60:34503
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.904992  2233 heartbeater.cc:461] Registering TS with master...
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.904994  2234 heartbeater.cc:507] Master 127.1.131.62:33909 requested a full tablet report, sending...
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905076  2233 heartbeater.cc:507] Master 127.1.131.60:34503 requested a full tablet report, sending...
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905462  1590 ts_manager.cc:194] Registered new tserver with Master: 595a409171c4467e9be468c4542cfd60 (127.1.131.3:38555)
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905504  1734 ts_manager.cc:194] Registered new tserver with Master: 595a409171c4467e9be468c4542cfd60 (127.1.131.3:38555)
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905535  2235 heartbeater.cc:344] Connected to a master server at 127.1.131.61:35297
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905580  2235 heartbeater.cc:461] Registering TS with master...
18:21:25.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905658  2235 heartbeater.cc:507] Master 127.1.131.61:35297 requested a full tablet report, sending...
18:21:25.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905923  1654 ts_manager.cc:194] Registered new tserver with Master: 595a409171c4467e9be468c4542cfd60 (127.1.131.3:38555)
18:21:25.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.905961  1734 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.1.131.3:53463
18:21:25.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.909046  1548 external_mini_cluster.cc:1434] Started /tmp/dist-test-task1tUVpC/build/release/bin/kudu as pid 2105
18:21:25.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.909163  1548 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task1tUVpC/test-tmp/mini-kudu-cluster16347250608537732196/ts-2/wal/instance
18:21:25.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:25.911845  1548 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:21:25.912 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:21:25.913 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:21:25.922 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.1.131.62"
      port: 33909
    }
    bound_http_address {
      host: "127.1.131.62"
      port: 42659
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.1.131.61"
      port: 35297
    }
    bound_http_address {
      host: "127.1.131.61"
      port: 43597
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.1.131.60"
      port: 34503
    }
    bound_http_address {
      host: "127.1.131.60"
      port: 34741
    }
  }
}

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

18:21:25.927 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.1.131.1"
      port: 38845
    }
    bound_http_address {
      host: "127.1.131.1"
      port: 43241
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.1.131.2"
      port: 42231
    }
    bound_http_address {
      host: "127.1.131.2"
      port: 38883
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.1.131.3"
      port: 38555
    }
    bound_http_address {
      host: "127.1.131.3"
      port: 35993
    }
  }
}

18:21:25.927 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:21:26.093 [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:21:26.147 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:21:26.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.297269  1791 catalog_manager.cc:1294] Loaded cluster ID: 85bcdc8b06584153a4344f3a80cb48e2
18:21:26.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.297394  1791 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: loading cluster ID for follower catalog manager: success
18:21:26.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.298640  1791 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: acquiring CA information for follower catalog manager: success
18:21:26.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.299000  1791 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 103b6b1855f24a7b840b15db5e9834c9: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:21:26.316 [DEBUG - main] (Connection.java:748) [peer master-127.1.131.61:35297(127.1.131.61:35297)] connecting to peer
18:21:26.390 [DEBUG - main] (Connection.java:748) [peer master-127.1.131.62:33909(127.1.131.62:33909)] connecting to peer
18:21:26.398 [DEBUG - main] (Connection.java:748) [peer master-127.1.131.60:34503(127.1.131.60:34503)] connecting to peer
18:21:26.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.400511  1828 catalog_manager.cc:1294] Loaded cluster ID: 85bcdc8b06584153a4344f3a80cb48e2
18:21:26.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.400589  1828 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: loading cluster ID for follower catalog manager: success
18:21:26.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.401980  1828 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: acquiring CA information for follower catalog manager: success
18:21:26.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.402314  1828 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 35e16b512ae64a238253afe1fb0ceb92: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:21:26.412 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.1.131.61:35297(127.1.131.61:35297)] Successfully connected to peer
18:21:26.413 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.1.131.60:34503(127.1.131.60:34503)] Successfully connected to peer
18:21:26.413 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.1.131.62:33909(127.1.131.62:33909)] Successfully connected to peer
18:21:26.517 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.131.61
18:21:26.517 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.131.60
18:21:26.517 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.1.131.62
18:21:26.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.656809  1964 heartbeater.cc:499] Master 127.1.131.60:34503 was elected leader, sending a full tablet report...
18:21:26.749 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x0349eb65, L:/127.0.0.1:41928 - R:/127.1.131.61:35297] using SASL/PLAIN
18:21:26.749 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xdb30e8d3, L:/127.0.0.1:38884 - R:/127.1.131.62:33909] using SASL/PLAIN
18:21:26.753 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x43be7b98, L:/127.0.0.1:54110 - R:/127.1.131.60:34503] using SASL/PLAIN
18:21:26.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.787367  2099 heartbeater.cc:499] Master 127.1.131.60:34503 was elected leader, sending a full tablet report...
18:21:26.794 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:21:26.795 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=528), Traces: [0ms] refreshing cache from master, [35ms] Sub RPC ConnectToMaster: sending RPC to server master-127.1.131.61:35297, [119ms] Sub RPC ConnectToMaster: sending RPC to server master-127.1.131.62:33909, [128ms] Sub RPC ConnectToMaster: sending RPC to server master-127.1.131.60:34503, [492ms] Sub RPC ConnectToMaster: received response from server master-127.1.131.62:33909: OK, [492ms] Sub RPC ConnectToMaster: received response from server master-127.1.131.61:35297: OK, [493ms] Sub RPC ConnectToMaster: received response from server master-127.1.131.60:34503: OK, deferred=null) after lookup
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.850067  1734 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:54110:
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783534884441"
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:21:26.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:21:26.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:26.850445  1734 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783534884441 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:21:26.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.860277  2167 tablet_service.cc:1511] Processing CreateTablet for tablet ea94b1c3bcdb4f7faf5e755bd156f49a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783534884441 [id=b64166b9f7df496c9da54aaebe42ed1b]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:26.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.860620  2167 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ea94b1c3bcdb4f7faf5e755bd156f49a. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:26.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.860673  2033 tablet_service.cc:1511] Processing CreateTablet for tablet ea94b1c3bcdb4f7faf5e755bd156f49a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783534884441 [id=b64166b9f7df496c9da54aaebe42ed1b]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:26.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.860929  2033 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ea94b1c3bcdb4f7faf5e755bd156f49a. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:26.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.861510  1898 tablet_service.cc:1511] Processing CreateTablet for tablet ea94b1c3bcdb4f7faf5e755bd156f49a (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783534884441 [id=b64166b9f7df496c9da54aaebe42ed1b]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:26.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.861774  1898 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ea94b1c3bcdb4f7faf5e755bd156f49a. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:26.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.864466  2265 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Bootstrap starting.
18:21:26.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.865355  2266 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Bootstrap starting.
18:21:26.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.865389  2265 tablet_bootstrap.cc:654] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Neither blocks nor log segments found. Creating new log.
18:21:26.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.865728  2265 log.cc:826] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Log is configured to *not* fsync() on all Append() calls
18:21:26.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.866333  2265 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: No bootstrap required, opened a new log
18:21:26.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.866400  2265 ts_tablet_manager.cc:1403] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Time spent bootstrapping tablet: real 0.002s	user 0.000s	sys 0.001s
18:21:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.868139  2265 raft_consensus.cc:359] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.868302  2265 raft_consensus.cc:385] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.868333  2265 raft_consensus.cc:740] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f813e278458e4abea584fd8d06496ced, State: Initialized, Role: FOLLOWER
18:21:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.868422  2265 consensus_queue.cc:260] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [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: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.868685  2265 ts_tablet_manager.cc:1434] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Time spent starting tablet: real 0.002s	user 0.000s	sys 0.002s
18:21:26.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.869524  2266 tablet_bootstrap.cc:654] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Neither blocks nor log segments found. Creating new log.
18:21:26.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.872169  2264 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Bootstrap starting.
18:21:26.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.872711  2264 tablet_bootstrap.cc:654] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Neither blocks nor log segments found. Creating new log.
18:21:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.872927  2264 log.cc:826] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Log is configured to *not* fsync() on all Append() calls
18:21:26.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.873425  2266 log.cc:826] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Log is configured to *not* fsync() on all Append() calls
18:21:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.874192  2264 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: No bootstrap required, opened a new log
18:21:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.874271  2264 ts_tablet_manager.cc:1403] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
18:21:26.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.874756  2266 tablet_bootstrap.cc:492] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: No bootstrap required, opened a new log
18:21:26.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.874846  2266 ts_tablet_manager.cc:1403] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Time spent bootstrapping tablet: real 0.010s	user 0.001s	sys 0.000s
18:21:26.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876035  2266 raft_consensus.cc:359] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876024  2264 raft_consensus.cc:359] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876187  2266 raft_consensus.cc:385] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:26.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876187  2264 raft_consensus.cc:385] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876223  2266 raft_consensus.cc:740] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d7864f4c377247f5a8c813e23678b1a8, State: Initialized, Role: FOLLOWER
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876225  2264 raft_consensus.cc:740] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 595a409171c4467e9be468c4542cfd60, State: Initialized, Role: FOLLOWER
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876319  2266 consensus_queue.cc:260] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [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: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876351  2264 consensus_queue.cc:260] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [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: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876583  2266 ts_tablet_manager.cc:1434] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Time spent starting tablet: real 0.002s	user 0.001s	sys 0.001s
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876586  2264 ts_tablet_manager.cc:1434] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
18:21:26.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:26.876691  2233 heartbeater.cc:499] Master 127.1.131.60:34503 was elected leader, sending a full tablet report...
18:21:26.881 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table b64166b9f7df496c9da54aaebe42ed1b
18:21:26.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:26.898277  1967 tablet.cc:2406] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:21:26.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:26.900777  2236 tablet.cc:2406] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:21:27.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:21:27.029397  2102 tablet.cc:2406] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:21:27.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.035194  2271 raft_consensus.cc:493] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:21:27.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.035326  2271 raft_consensus.cc:515] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:27.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.035692  2271 leader_election.cc:290] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 595a409171c4467e9be468c4542cfd60 (127.1.131.3:38555), f813e278458e4abea584fd8d06496ced (127.1.131.2:42231)
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.038901  2187 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ea94b1c3bcdb4f7faf5e755bd156f49a" candidate_uuid: "d7864f4c377247f5a8c813e23678b1a8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "595a409171c4467e9be468c4542cfd60" is_pre_election: true
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039098  2187 raft_consensus.cc:2468] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d7864f4c377247f5a8c813e23678b1a8 in term 0.
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039351  1851 leader_election.cc:304] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [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: 595a409171c4467e9be468c4542cfd60, d7864f4c377247f5a8c813e23678b1a8; no voters: 
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039397  2052 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ea94b1c3bcdb4f7faf5e755bd156f49a" candidate_uuid: "d7864f4c377247f5a8c813e23678b1a8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f813e278458e4abea584fd8d06496ced" is_pre_election: true
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039479  2271 raft_consensus.cc:2804] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039531  2271 raft_consensus.cc:493] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039549  2271 raft_consensus.cc:3060] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 0 FOLLOWER]: Advancing to term 1
18:21:27.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.039536  2052 raft_consensus.cc:2468] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d7864f4c377247f5a8c813e23678b1a8 in term 0.
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040236  2271 raft_consensus.cc:515] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040395  2271 leader_election.cc:290] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [CANDIDATE]: Term 1 election: Requested vote from peers 595a409171c4467e9be468c4542cfd60 (127.1.131.3:38555), f813e278458e4abea584fd8d06496ced (127.1.131.2:42231)
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040527  2187 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ea94b1c3bcdb4f7faf5e755bd156f49a" candidate_uuid: "d7864f4c377247f5a8c813e23678b1a8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "595a409171c4467e9be468c4542cfd60"
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040607  2187 raft_consensus.cc:3060] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 0 FOLLOWER]: Advancing to term 1
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040614  2052 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ea94b1c3bcdb4f7faf5e755bd156f49a" candidate_uuid: "d7864f4c377247f5a8c813e23678b1a8" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f813e278458e4abea584fd8d06496ced"
18:21:27.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.040690  2052 raft_consensus.cc:3060] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 0 FOLLOWER]: Advancing to term 1
18:21:27.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041427  2187 raft_consensus.cc:2468] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d7864f4c377247f5a8c813e23678b1a8 in term 1.
18:21:27.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041538  2052 raft_consensus.cc:2468] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d7864f4c377247f5a8c813e23678b1a8 in term 1.
18:21:27.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041635  1851 leader_election.cc:304] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [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: 595a409171c4467e9be468c4542cfd60, d7864f4c377247f5a8c813e23678b1a8; no voters: 
18:21:27.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041723  2271 raft_consensus.cc:2804] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 1 FOLLOWER]: Leader election won for term 1
18:21:27.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041883  2271 raft_consensus.cc:697] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [term 1 LEADER]: Becoming Leader. State: Replica: d7864f4c377247f5a8c813e23678b1a8, State: Running, Role: LEADER
18:21:27.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.041967  2271 consensus_queue.cc:237] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [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: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } }
18:21:27.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.042960  1734 catalog_manager.cc:5696] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 reported cstate change: term changed from 0 to 1, leader changed from <none> to d7864f4c377247f5a8c813e23678b1a8 (127.1.131.1). New cstate: current_term: 1 leader_uuid: "d7864f4c377247f5a8c813e23678b1a8" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "d7864f4c377247f5a8c813e23678b1a8" member_type: VOTER last_known_addr { host: "127.1.131.1" port: 38845 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 } health_report { overall_health: UNKNOWN } } }
18:21:27.080 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet ea94b1c3bcdb4f7faf5e755bd156f49a for table 'org.apache.kudu.client.TestHybridTime-1783534884441' with partition [<start>, <end>)
18:21:27.088 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a@[595a409171c4467e9be468c4542cfd60(127.1.131.3:38555),d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)[L],f813e278458e4abea584fd8d06496ced(127.1.131.2:42231)]}]
18:21:27.089 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=18), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.1.131.60:34503, [8ms] Sub RPC GetTableLocations: received response from server master-127.1.131.60:34503: OK, deferred=null) after lookup
18:21:27.099 [DEBUG - kudu-nio-2] (Connection.java:748) [peer d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)] connecting to peer
18:21:27.102 [DEBUG - kudu-nio-3] (Connection.java:757) [peer d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)] Successfully connected to peer
18:21:27.173 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x211798b4, L:/127.0.0.1:37654 - R:/127.1.131.1:38845] using TOKEN/null
18:21:27.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.176529  2052 raft_consensus.cc:1275] T ea94b1c3bcdb4f7faf5e755bd156f49a P f813e278458e4abea584fd8d06496ced [term 1 FOLLOWER]: Refusing update from remote peer d7864f4c377247f5a8c813e23678b1a8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:27.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.176554  2187 raft_consensus.cc:1275] T ea94b1c3bcdb4f7faf5e755bd156f49a P 595a409171c4467e9be468c4542cfd60 [term 1 FOLLOWER]: Refusing update from remote peer d7864f4c377247f5a8c813e23678b1a8: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:27.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.176916  2271 consensus_queue.cc:1048] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f813e278458e4abea584fd8d06496ced" member_type: VOTER last_known_addr { host: "127.1.131.2" port: 42231 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:27.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.177346  2271 consensus_queue.cc:1048] T ea94b1c3bcdb4f7faf5e755bd156f49a P d7864f4c377247f5a8c813e23678b1a8 [LEADER]: Connected to new peer: Peer: permanent_uuid: "595a409171c4467e9be468c4542cfd60" member_type: VOTER last_known_addr { host: "127.1.131.3" port: 38555 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:27.218 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.227 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.233 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.237 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@141158295(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:27.246 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.247 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@915052904(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:27.252 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.252 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1957921342(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:27.256 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:27.308 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.319 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305358918351839233) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.327 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305358918351839237) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.331 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305358918351839241) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.334 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305358918351839245) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.338 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305358918351839249) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.341 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305358918351839253) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.344 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305358918351839254) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783534884441, tablet=ea94b1c3bcdb4f7faf5e755bd156f49a, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:27.348 [DEBUG - main] (Connection.java:575) [peer master-127.1.131.62:33909(127.1.131.62:33909)] disconnecting while in state READY
18:21:27.349 [DEBUG - main] (Connection.java:575) [peer master-127.1.131.60:34503(127.1.131.60:34503)] disconnecting while in state READY
18:21:27.350 [DEBUG - main] (Connection.java:575) [peer master-127.1.131.61:35297(127.1.131.61:35297)] disconnecting while in state READY
18:21:27.355 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.1.131.60:34503(127.1.131.60:34503)] handling channelInactive
18:21:27.356 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.1.131.60:34503(127.1.131.60:34503)] cleaning up while in state READY due to: connection closed
18:21:27.362 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.1.131.62:33909(127.1.131.62:33909)] handling channelInactive
18:21:27.362 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.1.131.62:33909(127.1.131.62:33909)] cleaning up while in state READY due to: connection closed
18:21:27.362 [DEBUG - main] (Connection.java:575) [peer d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)] disconnecting while in state READY
18:21:27.363 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.1.131.61:35297(127.1.131.61:35297)] handling channelInactive
18:21:27.364 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.1.131.61:35297(127.1.131.61:35297)] cleaning up while in state READY due to: connection closed
18:21:27.370 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:21:27.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.376986  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 1836
18:21:27.382 [DEBUG - kudu-nio-3] (Connection.java:239) [peer d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)] handling channelInactive
18:21:27.382 [DEBUG - kudu-nio-3] (Connection.java:709) [peer d7864f4c377247f5a8c813e23678b1a8(127.1.131.1:38845)] cleaning up while in state READY due to: connection closed
18:21:27.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.385232  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 1971
18:21:27.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.392910  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 2105
18:21:27.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.400561  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 1559
18:21:27.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.407341  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 1630
18:21:27.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:21:27.413113  1548 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task1tUVpC/build/release/bin/kudu with pid 1698
18:21:27.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:21:27Z chronyd exiting

Time: 2.931

OK (1 test)

