JUnit version 4.13.2
.06:39:51.272 [INFO - main] (RandomUtils.java:49) Using random seed: 1783492791266
06:39:51.291 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
06:39:51.351 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
06:39:51.361 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskV7fF9g/test-tmp
06:39:51.365 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
06:39:51.369 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskV7fF9g/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
06:39:51.615 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

06:39:51.628 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:39:51.630 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:39:51.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.631492  2795 mini_oidc.cc:152] Starting JWKS server
06:39:51.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.633867  2795 webserver.cc:460] Webserver started at http://127.0.0.1:35787/ using document root <none> and password file <none>
06:39:51.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.634019  2795 mini_oidc.cc:189] Starting OIDC Discovery server
06:39:51.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.634276  2795 webserver.cc:460] Webserver started at http://127.0.0.1:33819/ using document root <none> and password file <none>
06:39:51.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:51Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
06:39:51.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:51Z Disabled control of system clock
06:39:51.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.655252  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:51.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/logs
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data/info.pb
06:39:51.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:51.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.254:46207
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.254
06:39:51.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:51.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json with env {}
06:39:51.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.781279  2806 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:51.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.781612  2806 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:51.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.781662  2806 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:51.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786320  2806 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:39:51.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786403  2806 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:51.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786424  2806 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:39:51.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786442  2806 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:39:51.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786460  2806 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:39:51.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.786474  2806 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35787/jwks.json
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.791731  2806 master_runner.cc:386] Master server non-default flags:
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:51.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data
06:39:51.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.254:46207
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:51.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data/info.pb
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.254
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:51.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2806
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/logs
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:51.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.793111  2806 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:51.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.794678  2806 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:51.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.805166  2811 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
06:39:51.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.805105  2812 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
06:39:51.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.805102  2814 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
06:39:51.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.805215  2806 server_base.cc:1034] running on GCE node
06:39:51.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.805980  2806 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:51.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.807228  2806 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:51.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.808418  2806 hybrid_clock.cc:648] HybridClock initialized: now 1783492791808359 us; error 82 us; skew 500 ppm
06:39:51.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.814421  2806 webserver.cc:460] Webserver started at http://127.2.186.254:39861/ using document root <none> and password file <none>
06:39:51.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.815191  2806 fs_manager.cc:359] Metadata directory not provided
06:39:51.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.815284  2806 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:51.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.815510  2806 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:51.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.817941  2806 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data/instance:
06:39:51.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5dcd9aec39394c6b85917e39cd445bdc"
06:39:51.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-hsjl"
06:39:51.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.818596  2806 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal/instance:
06:39:51.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5dcd9aec39394c6b85917e39cd445bdc"
06:39:51.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-hsjl"
06:39:51.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.823189  2806 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
06:39:51.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.826503  2820 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:51.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.828382  2806 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.002s
06:39:51.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.828539  2806 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal
06:39:51.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5dcd9aec39394c6b85917e39cd445bdc"
06:39:51.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:51 on dist-test-slave-hsjl"
06:39:51.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.828657  2806 fs_report.cc:383] FS layout report
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data/data
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:51.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:51.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:51.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.855664  2806 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:51.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.856601  2806 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:51.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.856787  2806 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:51.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.864498  2806 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.254:46207
06:39:51.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.864508  2872 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.254:46207 every 8 connection(s)
06:39:51.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.865769  2806 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/data/info.pb
06:39:51.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.866408  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 2806
06:39:51.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.866576  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-0/wal/instance
06:39:51.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.868530  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:51.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/logs
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data/info.pb
06:39:51.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:51.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.253:39795
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.253
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:51.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json with env {}
06:39:51.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.870071  2873 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:51.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.874624  2873 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } has no permanent_uuid. Determining permanent_uuid...
06:39:51.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.888702  2873 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } has no permanent_uuid. Determining permanent_uuid...
06:39:51.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.890095  2822 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.186.253:39795: connect: Connection refused (error 111)
06:39:51.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.891769  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.253:39795: Network error: Client connection negotiation failed: client connection to 127.2.186.253:39795: connect: Connection refused (error 111)
06:39:51.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:51.941198  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } attempt: 1
06:39:51.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.943022  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.253:39795: Network error: Client connection negotiation failed: client connection to 127.2.186.253:39795: connect: Connection refused (error 111)
06:39:51.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.998675  2875 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:51.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.999302  2875 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:52.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:51.999540  2875 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:52.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004556  2875 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:39:52.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004642  2875 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:52.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004664  2875 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:39:52.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004688  2875 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:39:52.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004706  2875 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:39:52.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.004721  2875 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35787/jwks.json
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.010058  2875 master_runner.cc:386] Master server non-default flags:
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.253:39795
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:52.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data/info.pb
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.253
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2875
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/logs
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:52.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.011281  2875 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.011263  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } attempt: 2
06:39:52.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.013475  2875 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:52.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.014117  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.253:39795: Network error: Client connection negotiation failed: client connection to 127.2.186.253:39795: connect: Connection refused (error 111)
06:39:52.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.023746  2883 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
06:39:52.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.023895  2884 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
06:39:52.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.023959  2875 server_base.cc:1034] running on GCE node
06:39:52.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.023713  2886 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
06:39:52.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.025271  2875 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:52.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.026612  2875 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:52.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.027817  2875 hybrid_clock.cc:648] HybridClock initialized: now 1783492792027802 us; error 48 us; skew 500 ppm
06:39:52.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.030068  2875 webserver.cc:460] Webserver started at http://127.2.186.253:41427/ using document root <none> and password file <none>
06:39:52.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.030715  2875 fs_manager.cc:359] Metadata directory not provided
06:39:52.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.030788  2875 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:52.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.031034  2875 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:52.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.033252  2875 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data/instance:
06:39:52.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34ffdb3c6c63412d899c3c7c2f567169"
06:39:52.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.033987  2875 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal/instance:
06:39:52.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34ffdb3c6c63412d899c3c7c2f567169"
06:39:52.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.038895  2875 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.006s	sys 0.000s
06:39:52.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.042387  2892 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:52.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.044535  2875 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.044718  2875 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "34ffdb3c6c63412d899c3c7c2f567169"
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.044859  2875 fs_report.cc:383] FS layout report
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data/data
06:39:52.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:52.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:52.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.063181  2875 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:52.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.064173  2875 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:52.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.064415  2875 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:52.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.072726  2875 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.253:39795
06:39:52.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.072742  2944 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.253:39795 every 8 connection(s)
06:39:52.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.073956  2875 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/data/info.pb
06:39:52.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.077943  2945 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.078027  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 2875
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.078118  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-1/wal/instance
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.078702  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:52.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/logs
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data/info.pb
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.252:46631
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.252
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:52.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:52.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json with env {}
06:39:52.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.083413  2945 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.096467  2945 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.105443  2945 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.105300  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } attempt: 3
06:39:52.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.106827  2896 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.108331  2945 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.111516  2873 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.113248  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.144485  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 1
06:39:52.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.146319  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.157673  2945 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 1
06:39:52.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.159375  2945 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.209254  2947 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:52.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.209589  2947 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:52.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.209631  2947 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.213914  2947 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.214002  2947 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.214021  2947 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.214038  2947 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.214056  2947 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:39:52.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.214069  2947 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:35787/jwks.json
06:39:52.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.219456  2947 master_runner.cc:386] Master server non-default flags:
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.252:46631
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:35787/jwks.json
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data/info.pb
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.252
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.2947
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/logs
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:52.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:52.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.220808  2947 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:52.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.221520  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 2
06:39:52.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.222801  2947 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:52.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.223204  2873 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.227589  2945 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 2
06:39:52.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.229405  2945 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.186.252:46631: Network error: Client connection negotiation failed: client connection to 127.2.186.252:46631: connect: Connection refused (error 111)
06:39:52.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.233642  2947 server_base.cc:1034] running on GCE node
06:39:52.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.233678  2958 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
06:39:52.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.233635  2955 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
06:39:52.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.233896  2956 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
06:39:52.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.234804  2947 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:52.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.236442  2947 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:52.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.237689  2947 hybrid_clock.cc:648] HybridClock initialized: now 1783492792237666 us; error 55 us; skew 500 ppm
06:39:52.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.240221  2947 webserver.cc:460] Webserver started at http://127.2.186.252:39341/ using document root <none> and password file <none>
06:39:52.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.241186  2947 fs_manager.cc:359] Metadata directory not provided
06:39:52.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.241304  2947 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:52.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.241608  2947 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:52.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.244143  2947 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data/instance:
06:39:52.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "396444d91ce0448d90a5c11d336d14cf"
06:39:52.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.244944  2947 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal/instance:
06:39:52.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "396444d91ce0448d90a5c11d336d14cf"
06:39:52.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.249859  2947 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.000s
06:39:52.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.253621  2964 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.255774  2947 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.256091  2947 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "396444d91ce0448d90a5c11d336d14cf"
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.256300  2947 fs_report.cc:383] FS layout report
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal
06:39:52.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data/data
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:52.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:52.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.276185  2947 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:52.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.277151  2947 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:52.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.277453  2947 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:52.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.285961  2947 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.252:46631
06:39:52.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.285987  3016 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.252:46631 every 8 connection(s)
06:39:52.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.287186  2947 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/data/info.pb
06:39:52.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.290989  3017 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:52.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.295003  3017 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.296236  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 2947
06:39:52.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.296370  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/master-2/wal/instance
06:39:52.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.308974  3017 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.315727  3017 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } has no permanent_uuid. Determining permanent_uuid...
06:39:52.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.320598  2945 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 3
06:39:52.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.322382  2873 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } attempt: 3
06:39:52.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.326651  3017 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: Bootstrap starting.
06:39:52.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.329886  3017 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: Neither blocks nor log segments found. Creating new log.
06:39:52.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.331318  2873 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: Bootstrap starting.
06:39:52.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.334002  2945 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: Bootstrap starting.
06:39:52.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.334120  2873 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: Neither blocks nor log segments found. Creating new log.
06:39:52.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.335134  2873 log.cc:824] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: Log is configured to *not* fsync() on all Append() calls
06:39:52.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.336869  2945 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: Neither blocks nor log segments found. Creating new log.
06:39:52.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.338176  2945 log.cc:824] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: Log is configured to *not* fsync() on all Append() calls
06:39:52.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.331811  3017 log.cc:824] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: Log is configured to *not* fsync() on all Append() calls
06:39:52.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.339031  2873 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: No bootstrap required, opened a new log
06:39:52.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.340727  3017 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: No bootstrap required, opened a new log
06:39:52.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.340883  2945 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: No bootstrap required, opened a new log
06:39:52.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.344970  3017 raft_consensus.cc:348] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.344965  2873 raft_consensus.cc:348] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345274  2873 raft_consensus.cc:374] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:52.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345274  3017 raft_consensus.cc:374] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:52.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345330  2873 raft_consensus.cc:729] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5dcd9aec39394c6b85917e39cd445bdc, State: Initialized, Role: FOLLOWER
06:39:52.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345342  3017 raft_consensus.cc:729] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 396444d91ce0448d90a5c11d336d14cf, State: Initialized, Role: FOLLOWER
06:39:52.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345849  2873 consensus_queue.cc:260] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345849  3017 consensus_queue.cc:260] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.347280  3017 sys_catalog.cc:564] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: configured and running, proceeding with master startup.
06:39:52.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.347328  2873 sys_catalog.cc:564] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: configured and running, proceeding with master startup.
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.353694  3051 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.353809  3051 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.345727  2945 raft_consensus.cc:348] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.356117  2945 raft_consensus.cc:374] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.356187  2945 raft_consensus.cc:729] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 34ffdb3c6c63412d899c3c7c2f567169, State: Initialized, Role: FOLLOWER
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.356709  2945 consensus_queue.cc:260] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.358470  2826 tablet.cc:2369] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.358290  2945 sys_catalog.cc:564] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: configured and running, proceeding with master startup.
06:39:52.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.358960  3054 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.359192  3054 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.362571  3030 sys_catalog.cc:455] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.362713  3030 sys_catalog.cc:458] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.355249  2947 master_runner.cc:186] Error getting master registration for 127.2.186.253:39795: OK, instance_id { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" instance_seqno: 1783492792070411 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.362936  3029 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.363016  2947 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.363070  3029 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.364990  3065 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.365088  3065 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.365358  3052 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:39:52.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.365419  3052 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:39:52.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.356602  2806 master_runner.cc:186] Error getting master registration for 127.2.186.253:39795: OK, instance_id { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" instance_seqno: 1783492792070411 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
06:39:52.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.370271  2806 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
06:39:52.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.370268  2875 master_runner.cc:263] No leader master found from master 34ffdb3c6c63412d899c3c7c2f567169
06:39:52.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.370352  2875 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
06:39:52.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.529189  2970 tablet.cc:2369] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:52.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.566268  2898 tablet.cc:2369] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:52.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.587194  3054 raft_consensus.cc:482] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
06:39:52.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.587393  3054 raft_consensus.cc:504] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.588630  3054 leader_election.cc:288] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 5dcd9aec39394c6b85917e39cd445bdc (127.2.186.254:46207), 396444d91ce0448d90a5c11d336d14cf (127.2.186.252:46631)
06:39:52.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.589314  2847 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34ffdb3c6c63412d899c3c7c2f567169" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5dcd9aec39394c6b85917e39cd445bdc" is_pre_election: true
06:39:52.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.589314  2991 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34ffdb3c6c63412d899c3c7c2f567169" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "396444d91ce0448d90a5c11d336d14cf" is_pre_election: true
06:39:52.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.589684  2991 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 34ffdb3c6c63412d899c3c7c2f567169 in term 0.
06:39:52.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.589684  2847 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 34ffdb3c6c63412d899c3c7c2f567169 in term 0.
06:39:52.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.590241  2893 leader_election.cc:302] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 3 yes votes; 0 no votes. yes voters: 34ffdb3c6c63412d899c3c7c2f567169, 396444d91ce0448d90a5c11d336d14cf, 5dcd9aec39394c6b85917e39cd445bdc; no voters: 
06:39:52.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.590621  3054 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Leader pre-election won for term 1
06:39:52.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.590759  3054 raft_consensus.cc:482] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
06:39:52.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.590824  3054 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 0 FOLLOWER]: Advancing to term 1
06:39:52.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.592056  3054 raft_consensus.cc:504] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.592536  3054 leader_election.cc:288] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [CANDIDATE]: Term 1 election: Requested vote from peers 5dcd9aec39394c6b85917e39cd445bdc (127.2.186.254:46207), 396444d91ce0448d90a5c11d336d14cf (127.2.186.252:46631)
06:39:52.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.593135  2847 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34ffdb3c6c63412d899c3c7c2f567169" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5dcd9aec39394c6b85917e39cd445bdc"
06:39:52.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.593137  2991 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "34ffdb3c6c63412d899c3c7c2f567169" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "396444d91ce0448d90a5c11d336d14cf"
06:39:52.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.593276  2847 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 0 FOLLOWER]: Advancing to term 1
06:39:52.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.593309  2991 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 0 FOLLOWER]: Advancing to term 1
06:39:52.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.594393  2847 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 34ffdb3c6c63412d899c3c7c2f567169 in term 1.
06:39:52.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.594492  2991 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 34ffdb3c6c63412d899c3c7c2f567169 in term 1.
06:39:52.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.594805  2893 leader_election.cc:302] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [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: 34ffdb3c6c63412d899c3c7c2f567169, 5dcd9aec39394c6b85917e39cd445bdc; no voters: 
06:39:52.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.595026  3054 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 1 FOLLOWER]: Leader election won for term 1
06:39:52.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.595213  3054 raft_consensus.cc:686] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [term 1 LEADER]: Becoming Leader. State: Replica: 34ffdb3c6c63412d899c3c7c2f567169, State: Running, Role: LEADER
06:39:52.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.595628  3054 consensus_queue.cc:237] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [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: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } }
06:39:52.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.598063  3068 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34ffdb3c6c63412d899c3c7c2f567169. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.598227  3068 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: This master's current role is: LEADER
06:39:52.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.598929  3070 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
06:39:52.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.600020  3070 catalog_manager.cc:1484] Initializing Kudu cluster ID...
06:39:52.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.605320  2991 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [term 1 FOLLOWER]: Refusing update from remote peer 34ffdb3c6c63412d899c3c7c2f567169: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:39:52.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.605325  2847 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [term 1 FOLLOWER]: Refusing update from remote peer 34ffdb3c6c63412d899c3c7c2f567169: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:39:52.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.606181  3054 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [LEADER]: Connected to new peer: Peer: permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:39:52.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.606567  3068 consensus_queue.cc:1035] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [LEADER]: Connected to new peer: Peer: permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:39:52.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.610680  3030 sys_catalog.cc:455] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34ffdb3c6c63412d899c3c7c2f567169. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.610680  3029 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: SysCatalogTable state changed. Reason: New leader 34ffdb3c6c63412d899c3c7c2f567169. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.610838  3030 sys_catalog.cc:458] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.610838  3029 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.612723  3054 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.612761  3068 sys_catalog.cc:455] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.612871  3054 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: This master's current role is: LEADER
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.612895  3068 sys_catalog.cc:458] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169 [sys.catalog]: This master's current role is: LEADER
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.612967  3071 mvcc.cc:205] Tried to move back new op lower bound from 7305186478503976960 to 7305186478475390976. Current Snapshot: MvccSnapshot[applied={T|T < 7305186478503976960}]
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.613554  3029 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.613670  3029 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.613704  3072 mvcc.cc:205] Tried to move back new op lower bound from 7305186478503976960 to 7305186478475390976. Current Snapshot: MvccSnapshot[applied={T|T < 7305186478503976960}]
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.613678  3030 sys_catalog.cc:455] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "34ffdb3c6c63412d899c3c7c2f567169" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5dcd9aec39394c6b85917e39cd445bdc" member_type: VOTER last_known_addr { host: "127.2.186.254" port: 46207 } } peers { permanent_uuid: "34ffdb3c6c63412d899c3c7c2f567169" member_type: VOTER last_known_addr { host: "127.2.186.253" port: 39795 } } peers { permanent_uuid: "396444d91ce0448d90a5c11d336d14cf" member_type: VOTER last_known_addr { host: "127.2.186.252" port: 46631 } } }
06:39:52.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.613799  3030 sys_catalog.cc:458] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf [sys.catalog]: This master's current role is: FOLLOWER
06:39:52.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.615677  3070 catalog_manager.cc:1347] Generated new cluster ID: ee8da908f58a453886bc27e6d8eee802
06:39:52.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.615761  3070 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
06:39:52.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.616549  3073 mvcc.cc:205] Tried to move back new op lower bound from 7305186478503976960 to 7305186478475390976. Current Snapshot: MvccSnapshot[applied={T|T < 7305186478503976960}]
06:39:52.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.633510  3070 catalog_manager.cc:1370] Generated new certificate authority record
06:39:52.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.634579  3070 catalog_manager.cc:1504] Loading token signing keys...
06:39:52.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.646096  3070 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 34ffdb3c6c63412d899c3c7c2f567169: Generated new TSK 0
06:39:52.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.647504  3070 catalog_manager.cc:1514] Initializing in-progress tserver states...
06:39:52.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.655529  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/logs
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data/info.pb
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.193:0
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.193
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.193
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:39:52.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.788702  3080 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:52.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.789069  3080 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:52.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.789113  3080 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:52.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.794312  3080 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:52.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.794448  3080 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.186.193
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.800886  3080 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.193:0
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data/info.pb
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.193
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:52.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.3080
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.193
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/logs
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:52.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.802150  3080 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:52.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.803764  3080 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:52.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.816111  3088 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
06:39:52.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.816102  3086 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
06:39:52.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:52.816100  3085 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
06:39:52.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.816448  3080 server_base.cc:1034] running on GCE node
06:39:52.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.817430  3080 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:52.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.818162  3080 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:52.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.819363  3080 hybrid_clock.cc:648] HybridClock initialized: now 1783492792819334 us; error 60 us; skew 500 ppm
06:39:52.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.822245  3080 webserver.cc:460] Webserver started at http://127.2.186.193:38357/ using document root <none> and password file <none>
06:39:52.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.822865  3080 fs_manager.cc:359] Metadata directory not provided
06:39:52.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.822935  3080 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:52.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.823181  3080 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:52.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.826027  3080 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data/instance:
06:39:52.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6076b29de7d943dcbe9566fa1e809e08"
06:39:52.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.826805  3080 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal/instance:
06:39:52.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6076b29de7d943dcbe9566fa1e809e08"
06:39:52.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.832413  3080 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.001s
06:39:52.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.835961  3094 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:52.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.837728  3080 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.837872  3080 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6076b29de7d943dcbe9566fa1e809e08"
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:52 on dist-test-slave-hsjl"
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.838001  3080 fs_report.cc:383] FS layout report
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data/data
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:52.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:52.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.862480  3080 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:52.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.863233  3080 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:52.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.863402  3080 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:52.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.864053  3080 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:52.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.865200  3080 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:52.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.865252  3080 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:52.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.865346  3080 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:52.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.865375  3080 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:52.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.876889  3080 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.193:36633
06:39:52.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.876909  3207 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.193:36633 every 8 connection(s)
06:39:52.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.879098  3080 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/data/info.pb
06:39:52.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.885898  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 3080
06:39:52.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.886034  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-0/wal/instance
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.888983  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:52.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/logs
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data/info.pb
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.194:0
06:39:52.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.194
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.194
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:52.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895128  3210 heartbeater.cc:347] Connected to a master server at 127.2.186.253:39795
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895123  3208 heartbeater.cc:347] Connected to a master server at 127.2.186.252:46631
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895506  3210 heartbeater.cc:464] Registering TS with master...
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895512  3208 heartbeater.cc:464] Registering TS with master...
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895535  3209 heartbeater.cc:347] Connected to a master server at 127.2.186.254:46207
06:39:52.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.895678  3209 heartbeater.cc:464] Registering TS with master...
06:39:52.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.896287  3210 heartbeater.cc:511] Master 127.2.186.253:39795 requested a full tablet report, sending...
06:39:52.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.896272  3208 heartbeater.cc:511] Master 127.2.186.252:46631 requested a full tablet report, sending...
06:39:52.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.896273  3209 heartbeater.cc:511] Master 127.2.186.254:46207 requested a full tablet report, sending...
06:39:52.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.898095  2981 ts_manager.cc:194] Registered new tserver with Master: 6076b29de7d943dcbe9566fa1e809e08 (127.2.186.193:36633)
06:39:52.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.898140  2837 ts_manager.cc:194] Registered new tserver with Master: 6076b29de7d943dcbe9566fa1e809e08 (127.2.186.193:36633)
06:39:52.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.898140  2908 ts_manager.cc:194] Registered new tserver with Master: 6076b29de7d943dcbe9566fa1e809e08 (127.2.186.193:36633)
06:39:52.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:52.899529  2908 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.186.193:33917
06:39:53.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.019944  3218 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:53.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.020292  3218 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:53.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.020346  3218 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:53.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.025192  3218 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:53.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.025372  3218 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.186.194
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.031111  3218 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.194:0
06:39:53.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data/info.pb
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.194
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.3218
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.194
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/logs
06:39:53.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:53.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.032734  3218 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:53.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.034401  3218 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:53.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.045373  3223 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
06:39:53.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.045373  3226 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
06:39:53.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.045373  3224 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
06:39:53.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.045645  3218 server_base.cc:1034] running on GCE node
06:39:53.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.046229  3218 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:53.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.047250  3218 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:53.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.048460  3218 hybrid_clock.cc:648] HybridClock initialized: now 1783492793048431 us; error 50 us; skew 500 ppm
06:39:53.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.051146  3218 webserver.cc:460] Webserver started at http://127.2.186.194:41269/ using document root <none> and password file <none>
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.052161  3218 fs_manager.cc:359] Metadata directory not provided
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.052394  3218 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:53.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.052716  3218 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.054893  3218 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data/instance:
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "120b7d4196014d2682c129a562245027"
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.055483  3218 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal/instance:
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "120b7d4196014d2682c129a562245027"
06:39:53.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.061013  3218 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.000s
06:39:53.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.064217  3232 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.066022  3218 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.001s
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.066205  3218 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "120b7d4196014d2682c129a562245027"
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.066354  3218 fs_report.cc:383] FS layout report
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data/data
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:53.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:53.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:53.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:53.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:53.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.104979  3218 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:53.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.105746  3218 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:53.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.106016  3218 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:53.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.106706  3218 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:53.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.107939  3218 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:53.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.108006  3218 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:53.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.108068  3218 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:53.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.108091  3218 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:53.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.118937  3218 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.194:34291
06:39:53.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.118981  3345 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.194:34291 every 8 connection(s)
06:39:53.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.120122  3218 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/data/info.pb
06:39:53.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.121104  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 3218
06:39:53.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.121208  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-1/wal/instance
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.124336  2795 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/logs
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data/info.pb
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.195:0
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.195
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.195
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.135764  3347 heartbeater.cc:347] Connected to a master server at 127.2.186.254:46207
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.135804  3348 heartbeater.cc:347] Connected to a master server at 127.2.186.253:39795
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.135872  3346 heartbeater.cc:347] Connected to a master server at 127.2.186.252:46631
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136102  3347 heartbeater.cc:464] Registering TS with master...
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136101  3346 heartbeater.cc:464] Registering TS with master...
06:39:53.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136101  3348 heartbeater.cc:464] Registering TS with master...
06:39:53.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136857  3346 heartbeater.cc:511] Master 127.2.186.252:46631 requested a full tablet report, sending...
06:39:53.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136857  3347 heartbeater.cc:511] Master 127.2.186.254:46207 requested a full tablet report, sending...
06:39:53.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.136857  3348 heartbeater.cc:511] Master 127.2.186.253:39795 requested a full tablet report, sending...
06:39:53.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.138208  2908 ts_manager.cc:194] Registered new tserver with Master: 120b7d4196014d2682c129a562245027 (127.2.186.194:34291)
06:39:53.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.138337  2981 ts_manager.cc:194] Registered new tserver with Master: 120b7d4196014d2682c129a562245027 (127.2.186.194:34291)
06:39:53.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.139066  2908 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.186.194:47105
06:39:53.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.139420  2837 ts_manager.cc:194] Registered new tserver with Master: 120b7d4196014d2682c129a562245027 (127.2.186.194:34291)
06:39:53.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.257256  3352 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:39:53.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.257658  3352 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:39:53.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.257709  3352 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:39:53.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.263792  3352 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:39:53.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.263965  3352 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.186.195
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.270123  3352 tablet_server_runner.cc:78] Tablet server non-default flags:
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.186.212:45979
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.186.195:0
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data/info.pb
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.186.195
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.186.254:46207,127.2.186.253:39795,127.2.186.252:46631
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.3352
06:39:53.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.186.195
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/logs
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:04:13 UTC on ccycloud.quasar-auftqw.root.comops.site
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492841
06:39:53.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.271406  3352 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:39:53.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.273077  3352 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:39:53.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.284801  3360 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
06:39:53.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.284791  3362 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
06:39:53.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:53.284791  3359 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
06:39:53.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.285748  3352 server_base.cc:1034] running on GCE node
06:39:53.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.286226  3352 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:39:53.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.286944  3352 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:39:53.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.288247  3352 hybrid_clock.cc:648] HybridClock initialized: now 1783492793288196 us; error 47 us; skew 500 ppm
06:39:53.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.290930  3352 webserver.cc:460] Webserver started at http://127.2.186.195:39301/ using document root <none> and password file <none>
06:39:53.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.291633  3352 fs_manager.cc:359] Metadata directory not provided
06:39:53.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.291762  3352 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:39:53.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.292092  3352 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:39:53.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.294265  3352 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data/instance:
06:39:53.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8c69e21a63d24d5faa4e778a86b1aa28"
06:39:53.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.295047  3352 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal/instance:
06:39:53.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8c69e21a63d24d5faa4e778a86b1aa28"
06:39:53.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.300371  3352 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.007s	sys 0.000s
06:39:53.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.303532  3368 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:39:53.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.305599  3352 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
06:39:53.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.305804  3352 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data,/tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8c69e21a63d24d5faa4e778a86b1aa28"
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 06:39:53 on dist-test-slave-hsjl"
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.305950  3352 fs_report.cc:383] FS layout report
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data/data
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:39:53.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:39:53.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.322422  3352 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:39:53.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.323431  3352 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
06:39:53.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.323719  3352 kserver.cc:163] Server-wide thread pool size limit: 3276
06:39:53.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.324520  3352 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:39:53.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.325733  3352 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:39:53.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.325829  3352 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:39:53.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.325899  3352 ts_tablet_manager.cc:610] Registered 0 tablets
06:39:53.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.325932  3352 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:39:53.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.337838  3352 rpc_server.cc:307] RPC server started. Bound to: 127.2.186.195:38443
06:39:53.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.338011  3481 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.186.195:38443 every 8 connection(s)
06:39:53.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.339037  3352 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/data/info.pb
06:39:53.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.343361  2795 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu as pid 3352
06:39:53.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.343509  2795 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskV7fF9g/test-tmp/mini-kudu-cluster1610038926787415887/ts-2/wal/instance
06:39:53.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.355281  3051 catalog_manager.cc:1259] Loaded cluster ID: ee8da908f58a453886bc27e6d8eee802
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.355255  3483 heartbeater.cc:347] Connected to a master server at 127.2.186.254:46207
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.355410  3051 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: loading cluster ID for follower catalog manager: success
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.355547  3483 heartbeater.cc:464] Registering TS with master...
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.355945  3484 heartbeater.cc:347] Connected to a master server at 127.2.186.253:39795
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.356047  3484 heartbeater.cc:464] Registering TS with master...
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.356459  3482 heartbeater.cc:347] Connected to a master server at 127.2.186.252:46631
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.356696  3484 heartbeater.cc:511] Master 127.2.186.253:39795 requested a full tablet report, sending...
06:39:53.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.356700  3482 heartbeater.cc:464] Registering TS with master...
06:39:53.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.357160  3482 heartbeater.cc:511] Master 127.2.186.252:46631 requested a full tablet report, sending...
06:39:53.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.357410  3483 heartbeater.cc:511] Master 127.2.186.254:46207 requested a full tablet report, sending...
06:39:53.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.357875  3051 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: acquiring CA information for follower catalog manager: success
06:39:53.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.358330  2908 ts_manager.cc:194] Registered new tserver with Master: 8c69e21a63d24d5faa4e778a86b1aa28 (127.2.186.195:38443)
06:39:53.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.359026  2837 ts_manager.cc:194] Registered new tserver with Master: 8c69e21a63d24d5faa4e778a86b1aa28 (127.2.186.195:38443)
06:39:53.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.359069  2908 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.186.195:54767
06:39:53.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.359100  2981 ts_manager.cc:194] Registered new tserver with Master: 8c69e21a63d24d5faa4e778a86b1aa28 (127.2.186.195:38443)
06:39:53.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.359588  3051 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 5dcd9aec39394c6b85917e39cd445bdc: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
06:39:53.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.366930  3052 catalog_manager.cc:1259] Loaded cluster ID: ee8da908f58a453886bc27e6d8eee802
06:39:53.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.367038  3052 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: loading cluster ID for follower catalog manager: success
06:39:53.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.368562  2795 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
06:39:53.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.369544  3052 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: acquiring CA information for follower catalog manager: success
06:39:53.370 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:39:53.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.370872  3052 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 396444d91ce0448d90a5c11d336d14cf: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
06:39:53.371 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

06:39:53.385 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.186.254"
      port: 46207
    }
    bound_http_address {
      host: "127.2.186.254"
      port: 39861
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.186.253"
      port: 39795
    }
    bound_http_address {
      host: "127.2.186.253"
      port: 41427
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.186.252"
      port: 46631
    }
    bound_http_address {
      host: "127.2.186.252"
      port: 39341
    }
  }
}

06:39:53.390 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

06:39:53.392 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.186.193"
      port: 36633
    }
    bound_http_address {
      host: "127.2.186.193"
      port: 38357
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.186.194"
      port: 34291
    }
    bound_http_address {
      host: "127.2.186.194"
      port: 41269
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.186.195"
      port: 38443
    }
    bound_http_address {
      host: "127.2.186.195"
      port: 39301
    }
  }
}

06:39:53.393 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
06:39:53.627 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
06:39:53.830 [DEBUG - main] (Connection.java:748) [peer master-127.2.186.253:39795(127.2.186.253:39795)] connecting to peer
06:39:53.899 [DEBUG - main] (Connection.java:748) [peer master-127.2.186.254:46207(127.2.186.254:46207)] connecting to peer
06:39:53.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:53.902563  3210 heartbeater.cc:503] Master 127.2.186.253:39795 was elected leader, sending a full tablet report...
06:39:53.902 [DEBUG - main] (Connection.java:748) [peer master-127.2.186.252:46631(127.2.186.252:46631)] connecting to peer
06:39:53.929 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.2.186.254:46207(127.2.186.254:46207)] Successfully connected to peer
06:39:53.929 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.186.253:39795(127.2.186.253:39795)] Successfully connected to peer
06:39:54.004 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.186.252:46631(127.2.186.252:46631)] Successfully connected to peer
06:39:54.036 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.186.253
06:39:54.036 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.186.254
06:39:54.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.141888  3348 heartbeater.cc:503] Master 127.2.186.253:39795 was elected leader, sending a full tablet report...
06:39:54.237 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.186.252
06:39:54.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.361351  3484 heartbeater.cc:503] Master 127.2.186.253:39795 was elected leader, sending a full tablet report...
06:39:54.399 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x794cd9e8, L:/127.0.0.1:45808 - R:/127.2.186.254:46207] using SASL/PLAIN
06:39:54.399 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x4b298521, L:/127.0.0.1:52898 - R:/127.2.186.253:39795] using SASL/PLAIN
06:39:54.443 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
06:39:54.444 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=659), Traces: [0ms] refreshing cache from master, [32ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.186.253:39795, [110ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.186.254:46207, [113ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.186.252:46631, [626ms] Sub RPC ConnectToMaster: received response from server master-127.2.186.254:46207: OK, [627ms] Sub RPC ConnectToMaster: received response from server master-127.2.186.253:39795: OK, deferred=null) after lookup
06:39:54.521 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x57c77207, L:/127.0.0.1:40532 - R:/127.2.186.252:46631] using SASL/PLAIN
06:39:54.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.519312  2908 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:52898:
06:39:54.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783492791181"
06:39:54.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
06:39:54.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
06:39:54.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:54.526015  2908 catalog_manager.cc:6854] 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-1783492791181 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
06:39:54.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.553982  3280 tablet_service.cc:1467] Processing CreateTablet for tablet e425d2b52f164d0caca6f3e826eae090 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783492791181 [id=3baab0089854404386d1bd3822317e9a]), partition=RANGE (key) PARTITION UNBOUNDED
06:39:54.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.555694  3280 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e425d2b52f164d0caca6f3e826eae090. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:54.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.558079  3142 tablet_service.cc:1467] Processing CreateTablet for tablet e425d2b52f164d0caca6f3e826eae090 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783492791181 [id=3baab0089854404386d1bd3822317e9a]), partition=RANGE (key) PARTITION UNBOUNDED
06:39:54.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.559492  3142 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e425d2b52f164d0caca6f3e826eae090. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:54.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.565865  3416 tablet_service.cc:1467] Processing CreateTablet for tablet e425d2b52f164d0caca6f3e826eae090 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783492791181 [id=3baab0089854404386d1bd3822317e9a]), partition=RANGE (key) PARTITION UNBOUNDED
06:39:54.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.567209  3416 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e425d2b52f164d0caca6f3e826eae090. 1 dirs total, 0 dirs full, 0 dirs failed
06:39:54.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.568331  3513 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Bootstrap starting.
06:39:54.569 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 3baab0089854404386d1bd3822317e9a
06:39:54.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.571137  3513 tablet_bootstrap.cc:654] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Neither blocks nor log segments found. Creating new log.
06:39:54.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.572207  3513 log.cc:824] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Log is configured to *not* fsync() on all Append() calls
06:39:54.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.573185  3514 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Bootstrap starting.
06:39:54.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.574769  3516 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Bootstrap starting.
06:39:54.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.575488  3514 tablet_bootstrap.cc:654] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Neither blocks nor log segments found. Creating new log.
06:39:54.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.576440  3514 log.cc:824] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Log is configured to *not* fsync() on all Append() calls
06:39:54.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.577651  3516 tablet_bootstrap.cc:654] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Neither blocks nor log segments found. Creating new log.
06:39:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.577965  3513 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: No bootstrap required, opened a new log
06:39:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.578218  3513 ts_tablet_manager.cc:1397] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Time spent bootstrapping tablet: real 0.010s	user 0.005s	sys 0.000s
06:39:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.578238  3514 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: No bootstrap required, opened a new log
06:39:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.578444  3514 ts_tablet_manager.cc:1397] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Time spent bootstrapping tablet: real 0.005s	user 0.004s	sys 0.000s
06:39:54.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.578619  3516 log.cc:824] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Log is configured to *not* fsync() on all Append() calls
06:39:54.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.580936  3516 tablet_bootstrap.cc:492] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: No bootstrap required, opened a new log
06:39:54.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.581184  3516 ts_tablet_manager.cc:1397] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
06:39:54.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.582397  3514 raft_consensus.cc:348] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.582681  3514 raft_consensus.cc:374] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:54.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.582733  3514 raft_consensus.cc:729] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6076b29de7d943dcbe9566fa1e809e08, State: Initialized, Role: FOLLOWER
06:39:54.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.583278  3514 consensus_queue.cc:260] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [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: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.583550  3513 raft_consensus.cc:348] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.584052  3513 raft_consensus.cc:374] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:54.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.584259  3513 raft_consensus.cc:729] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 120b7d4196014d2682c129a562245027, State: Initialized, Role: FOLLOWER
06:39:54.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.584606  3514 ts_tablet_manager.cc:1428] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Time spent starting tablet: real 0.006s	user 0.007s	sys 0.000s
06:39:54.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.585318  3513 consensus_queue.cc:260] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [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: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.589921  3513 ts_tablet_manager.cc:1428] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Time spent starting tablet: real 0.012s	user 0.004s	sys 0.005s
06:39:54.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.591534  3516 raft_consensus.cc:348] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.592075  3516 raft_consensus.cc:374] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:39:54.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.592346  3516 raft_consensus.cc:729] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 8c69e21a63d24d5faa4e778a86b1aa28, State: Initialized, Role: FOLLOWER
06:39:54.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.593070  3516 consensus_queue.cc:260] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [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: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.594789  3516 ts_tablet_manager.cc:1428] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Time spent starting tablet: real 0.014s	user 0.009s	sys 0.000s
06:39:54.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:54.622748  3349 tablet.cc:2369] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:54.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:54.634481  3211 tablet.cc:2369] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:54.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.788942  3520 raft_consensus.cc:482] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
06:39:54.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.789268  3520 raft_consensus.cc:504] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.790797  3520 leader_election.cc:288] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 6076b29de7d943dcbe9566fa1e809e08 (127.2.186.193:36633), 8c69e21a63d24d5faa4e778a86b1aa28 (127.2.186.195:38443)
06:39:54.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.796284  3162 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e425d2b52f164d0caca6f3e826eae090" candidate_uuid: "120b7d4196014d2682c129a562245027" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6076b29de7d943dcbe9566fa1e809e08" is_pre_election: true
06:39:54.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.796284  3436 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e425d2b52f164d0caca6f3e826eae090" candidate_uuid: "120b7d4196014d2682c129a562245027" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" is_pre_election: true
06:39:54.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.796700  3436 raft_consensus.cc:2454] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 120b7d4196014d2682c129a562245027 in term 0.
06:39:54.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.796700  3162 raft_consensus.cc:2454] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 120b7d4196014d2682c129a562245027 in term 0.
06:39:54.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.797335  3235 leader_election.cc:302] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 3 yes votes; 0 no votes. yes voters: 120b7d4196014d2682c129a562245027, 6076b29de7d943dcbe9566fa1e809e08, 8c69e21a63d24d5faa4e778a86b1aa28; no voters: 
06:39:54.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.797685  3520 raft_consensus.cc:2781] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Leader pre-election won for term 1
06:39:54.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.797781  3520 raft_consensus.cc:482] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
06:39:54.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.797830  3520 raft_consensus.cc:3037] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 0 FOLLOWER]: Advancing to term 1
06:39:54.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.798934  3520 raft_consensus.cc:504] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.799367  3520 leader_election.cc:288] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [CANDIDATE]: Term 1 election: Requested vote from peers 6076b29de7d943dcbe9566fa1e809e08 (127.2.186.193:36633), 8c69e21a63d24d5faa4e778a86b1aa28 (127.2.186.195:38443)
06:39:54.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.799888  3436 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e425d2b52f164d0caca6f3e826eae090" candidate_uuid: "120b7d4196014d2682c129a562245027" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8c69e21a63d24d5faa4e778a86b1aa28"
06:39:54.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.799918  3162 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e425d2b52f164d0caca6f3e826eae090" candidate_uuid: "120b7d4196014d2682c129a562245027" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6076b29de7d943dcbe9566fa1e809e08"
06:39:54.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.800035  3436 raft_consensus.cc:3037] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 0 FOLLOWER]: Advancing to term 1
06:39:54.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.800109  3162 raft_consensus.cc:3037] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 0 FOLLOWER]: Advancing to term 1
06:39:54.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.801108  3436 raft_consensus.cc:2454] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 120b7d4196014d2682c129a562245027 in term 1.
06:39:54.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.801334  3162 raft_consensus.cc:2454] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 120b7d4196014d2682c129a562245027 in term 1.
06:39:54.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.801542  3233 leader_election.cc:302] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [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: 120b7d4196014d2682c129a562245027, 8c69e21a63d24d5faa4e778a86b1aa28; no voters: 
06:39:54.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.801820  3520 raft_consensus.cc:2781] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 1 FOLLOWER]: Leader election won for term 1
06:39:54.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.802151  3520 raft_consensus.cc:686] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [term 1 LEADER]: Becoming Leader. State: Replica: 120b7d4196014d2682c129a562245027, State: Running, Role: LEADER
06:39:54.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.802573  3520 consensus_queue.cc:237] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [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: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } }
06:39:54.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.806783  2909 catalog_manager.cc:5495] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 reported cstate change: term changed from 0 to 1, leader changed from <none> to 120b7d4196014d2682c129a562245027 (127.2.186.194). New cstate: current_term: 1 leader_uuid: "120b7d4196014d2682c129a562245027" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "120b7d4196014d2682c129a562245027" member_type: VOTER last_known_addr { host: "127.2.186.194" port: 34291 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 } health_report { overall_health: UNKNOWN } } }
06:39:54.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:54.842278  3485 tablet.cc:2369] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28: Can't schedule compaction. Clean time has not been advanced past its initial value.
06:39:54.855 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet e425d2b52f164d0caca6f3e826eae090 for table 'org.apache.kudu.client.TestHybridTime-1783492791181' with partition [<start>, <end>)
06:39:54.863 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=e425d2b52f164d0caca6f3e826eae090@[120b7d4196014d2682c129a562245027(127.2.186.194:34291)[L],6076b29de7d943dcbe9566fa1e809e08(127.2.186.193:36633),8c69e21a63d24d5faa4e778a86b1aa28(127.2.186.195:38443)]}]
06:39:54.868 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=27), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.2.186.253:39795, [11ms] Sub RPC GetTableLocations: received response from server master-127.2.186.253:39795: OK, deferred=null) after lookup
06:39:54.881 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 120b7d4196014d2682c129a562245027(127.2.186.194:34291)] connecting to peer
06:39:54.884 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 120b7d4196014d2682c129a562245027(127.2.186.194:34291)] Successfully connected to peer
06:39:54.963 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x5816dd0d, L:/127.0.0.1:32784 - R:/127.2.186.194:34291] using TOKEN/null
06:39:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.971333  3436 raft_consensus.cc:1261] T e425d2b52f164d0caca6f3e826eae090 P 8c69e21a63d24d5faa4e778a86b1aa28 [term 1 FOLLOWER]: Refusing update from remote peer 120b7d4196014d2682c129a562245027: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:39:54.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.971329  3162 raft_consensus.cc:1261] T e425d2b52f164d0caca6f3e826eae090 P 6076b29de7d943dcbe9566fa1e809e08 [term 1 FOLLOWER]: Refusing update from remote peer 120b7d4196014d2682c129a562245027: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
06:39:54.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.972220  3524 consensus_queue.cc:1035] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [LEADER]: Connected to new peer: Peer: permanent_uuid: "8c69e21a63d24d5faa4e778a86b1aa28" member_type: VOTER last_known_addr { host: "127.2.186.195" port: 38443 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:39:54.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.972471  3520 consensus_queue.cc:1035] T e425d2b52f164d0caca6f3e826eae090 P 120b7d4196014d2682c129a562245027 [LEADER]: Connected to new peer: Peer: permanent_uuid: "6076b29de7d943dcbe9566fa1e809e08" member_type: VOTER last_known_addr { host: "127.2.186.193" port: 36633 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
06:39:54.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.981567  3527 mvcc.cc:205] Tried to move back new op lower bound from 7305186488192909312 to 7305186487514689536. Current Snapshot: MvccSnapshot[applied={T|T < 7305186488192909312}]
06:39:54.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:54.986423  3529 mvcc.cc:205] Tried to move back new op lower bound from 7305186488192909312 to 7305186487514689536. Current Snapshot: MvccSnapshot[applied={T|T < 7305186488192909312 or (T in {7305186488192909312})}]
06:39:55.029 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.046 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.056 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.060 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1919740908(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:39:55.074 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.074 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1656136674(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:39:55.084 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.085 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@930050044(state=PENDING, result=null, callback=<none>, errback=<none>)}
06:39:55.095 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
06:39:55.139 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.147 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305186508672909313) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.153 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305186508672909317) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.159 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305186508672909321) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.166 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305186508672909325) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.171 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305186508672909329) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.177 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305186508672909332) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.182 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305186508672909333) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783492791181, tablet=e425d2b52f164d0caca6f3e826eae090, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
06:39:55.186 [DEBUG - main] (Connection.java:575) [peer master-127.2.186.252:46631(127.2.186.252:46631)] disconnecting while in state READY
06:39:55.187 [DEBUG - main] (Connection.java:575) [peer master-127.2.186.253:39795(127.2.186.253:39795)] disconnecting while in state READY
06:39:55.188 [DEBUG - main] (Connection.java:575) [peer 120b7d4196014d2682c129a562245027(127.2.186.194:34291)] disconnecting while in state READY
06:39:55.188 [DEBUG - main] (Connection.java:575) [peer master-127.2.186.254:46207(127.2.186.254:46207)] disconnecting while in state READY
06:39:55.199 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.186.252:46631(127.2.186.252:46631)] handling channelInactive
06:39:55.200 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
06:39:55.201 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.186.252:46631(127.2.186.252:46631)] cleaning up while in state READY due to: connection closed
06:39:55.201 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 120b7d4196014d2682c129a562245027(127.2.186.194:34291)] handling channelInactive
06:39:55.202 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.186.253:39795(127.2.186.253:39795)] handling channelInactive
06:39:55.202 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.186.253:39795(127.2.186.253:39795)] cleaning up while in state READY due to: connection closed
06:39:55.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.201828  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 3080
06:39:55.204 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 120b7d4196014d2682c129a562245027(127.2.186.194:34291)] cleaning up while in state READY due to: connection closed
06:39:55.204 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.2.186.254:46207(127.2.186.254:46207)] handling channelInactive
06:39:55.204 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.2.186.254:46207(127.2.186.254:46207)] cleaning up while in state READY due to: connection closed
06:39:55.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.211194  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 3218
06:39:55.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.217577  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 3352
06:39:55.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.224092  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 2806
06:39:55.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 06:39:55.230945  2893 connection.cc:535] client connection to 127.2.186.254:46207 recv error: Network error: recv error from unknown peer: Transport endpoint is not connected (error 107)
06:39:55.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.231220  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 2875
06:39:55.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 06:39:55.238027  2795 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskV7fF9g/build/debug/bin/kudu with pid 2947
06:39:55.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T06:39:55Z chronyd exiting

Time: 4.32

OK (1 test)

