JUnit version 4.13.2
.17:13:19.982 [INFO - main] (RandomUtils.java:49) Using random seed: 1783530799977
17:13:19.999 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
17:13:20.049 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
17:13:20.058 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task3YOomn/test-tmp
17:13:20.060 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
17:13:20.063 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task3YOomn/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
17:13:20.292 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

17:13:20.445 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
17:13:20.446 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

17:13:20.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.450476  2735 mini_oidc.cc:152] Starting JWKS server
17:13:20.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.454391  2735 webserver.cc:460] Webserver started at http://127.0.0.1:45947/ using document root <none> and password file <none>
17:13:20.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.454932  2735 mini_oidc.cc:189] Starting OIDC Discovery server
17:13:20.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.457409  2735 webserver.cc:460] Webserver started at http://127.0.0.1:39203/ using document root <none> and password file <none>
17:13:20.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T17:13:20Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
17:13:20.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T17:13:20Z Disabled control of system clock
17:13:20.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.509569  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:20.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:20.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal
17:13:20.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:20.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:20.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/logs
17:13:20.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data/info.pb
17:13:20.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:20.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:20.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.254:42715
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.254
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:20.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:20.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json with env {}
17:13:20.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.811646  2747 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:20.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.812331  2747 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:20.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.812842  2747 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:20.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.844530  2747 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
17:13:20.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.844878  2747 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:20.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.845078  2747 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
17:13:20.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.845336  2747 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
17:13:20.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.845562  2747 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
17:13:20.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.845793  2747 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45947/jwks.json
17:13:20.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.881570  2747 master_runner.cc:386] Master server non-default flags:
17:13:20.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:20.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:20.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:20.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:20.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.254:42715
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:20.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data/info.pb
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.254
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/logs
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:20.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:20.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.882768  2747 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:20.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.884683  2747 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:20.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.906489  2753 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
17:13:22.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.906678  2754 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
17:13:22.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:20.906687  2756 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
17:13:22.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:20.907624  2747 server_base.cc:1034] running on GCE node
17:13:22.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.122301  2747 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:22.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.125370  2747 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:22.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.126788  2747 hybrid_clock.cc:648] HybridClock initialized: now 1783530802126757 us; error 55 us; skew 500 ppm
17:13:22.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.127606  2747 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:22.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.137998  2747 webserver.cc:460] Webserver started at http://127.2.171.254:46413/ using document root <none> and password file <none>
17:13:22.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.138931  2747 fs_manager.cc:359] Metadata directory not provided
17:13:22.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.139112  2747 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:22.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.139497  2747 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:22.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.144539  2747 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data/instance:
17:13:22.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "17f7c399c7b749c7bc7bd021361be57a"
17:13:22.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:22 on dist-test-slave-r7jh"
17:13:22.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.145752  2747 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal/instance:
17:13:22.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "17f7c399c7b749c7bc7bd021361be57a"
17:13:22.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:22 on dist-test-slave-r7jh"
17:13:22.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.153092  2747 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.001s
17:13:22.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.158809  2763 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:22.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.160035  2747 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.005s
17:13:22.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.160367  2747 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal
17:13:22.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "17f7c399c7b749c7bc7bd021361be57a"
17:13:22.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:22 on dist-test-slave-r7jh"
17:13:22.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.160761  2747 fs_report.cc:383] FS layout report
17:13:22.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:22.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data/data
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:22.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:22.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:22.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:22.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:22.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:22.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:22.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.192087  2747 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:22.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.193643  2747 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
17:13:22.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.194067  2747 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.266520  2747 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.254:42715
17:13:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.266625  2814 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.254:42715 every 8 connection(s)
17:13:22.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.269367  2747 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/data/info.pb
17:13:22.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.275173  2815 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:22.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.275095  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 2747
17:13:22.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.275637  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-0/wal/instance
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.280895  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/logs
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data/info.pb
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.253:33691
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.253
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:22.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json with env {}
17:13:22.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.289748  2815 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } has no permanent_uuid. Determining permanent_uuid...
17:13:22.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.318961  2815 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } has no permanent_uuid. Determining permanent_uuid...
17:13:22.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.321254  2766 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.325104  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.374603  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 1
17:13:22.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.378679  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.447077  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 2
17:13:22.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.450894  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.542331  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 3
17:13:22.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.548172  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.597339  2817 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:22.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.597878  2817 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:22.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.598318  2817 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.629714  2817 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.630036  2817 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.630249  2817 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.630440  2817 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.630628  2817 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
17:13:22.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.630770  2817 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45947/jwks.json
17:13:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.665076  2817 master_runner.cc:386] Master server non-default flags:
17:13:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:22.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.253:33691
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data/info.pb
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.253
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/logs
17:13:22.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:22.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.666392  2817 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:22.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.667876  2817 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:22.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.686821  2827 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
17:13:22.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.691617  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 4
17:13:22.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.695801  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:22.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.995285  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 5
17:13:23.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:23.000627  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:23.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.548053  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 6
17:13:23.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:23.554999  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.253:33691: Network error: Client connection negotiation failed: client connection to 127.2.171.253:33691: connect: Connection refused (error 111)
17:13:23.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.686857  2829 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
17:13:23.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:22.687668  2826 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
17:13:23.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:22.689100  2817 server_base.cc:1034] running on GCE node
17:13:23.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.903381  2817 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:23.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.906303  2817 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:23.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.907678  2817 hybrid_clock.cc:648] HybridClock initialized: now 1783530803907657 us; error 66 us; skew 500 ppm
17:13:23.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.908761  2817 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:23.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.916482  2817 webserver.cc:460] Webserver started at http://127.2.171.253:40449/ using document root <none> and password file <none>
17:13:23.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.917578  2817 fs_manager.cc:359] Metadata directory not provided
17:13:23.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.917791  2817 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:23.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.918202  2817 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:23.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.923753  2817 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data/instance:
17:13:23.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2883dc84bc0b446794a685ae8f3d4a53"
17:13:23.924 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:23 on dist-test-slave-r7jh"
17:13:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.925063  2817 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal/instance:
17:13:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2883dc84bc0b446794a685ae8f3d4a53"
17:13:23.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:23 on dist-test-slave-r7jh"
17:13:23.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.932761  2817 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.001s
17:13:23.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.938973  2838 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:23.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.940094  2817 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.006s	sys 0.001s
17:13:23.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.940482  2817 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal
17:13:23.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2883dc84bc0b446794a685ae8f3d4a53"
17:13:23.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:23 on dist-test-slave-r7jh"
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.940833  2817 fs_report.cc:383] FS layout report
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data/data
17:13:23.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:23.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:23.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.991348  2817 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:23.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.992913  2817 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
17:13:23.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:23.993341  2817 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:24.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.069836  2817 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.253:33691
17:13:24.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.069918  2889 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.253:33691 every 8 connection(s)
17:13:24.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.072525  2817 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/data/info.pb
17:13:24.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.075254  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 2817
17:13:24.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.075717  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-1/wal/instance
17:13:24.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.078100  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:24.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:24.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal
17:13:24.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data
17:13:24.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/logs
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data/info.pb
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:24.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.252:39241
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.252
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:24.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json with env {}
17:13:24.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.078632  2890 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:24.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.094259  2890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } has no permanent_uuid. Determining permanent_uuid...
17:13:24.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.119293  2890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } has no permanent_uuid. Determining permanent_uuid...
17:13:24.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.136204  2890 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } has no permanent_uuid. Determining permanent_uuid...
17:13:24.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.138273  2842 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.142747  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.192260  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 1
17:13:24.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.196451  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.264810  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 2
17:13:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.268465  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.359867  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 3
17:13:24.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.363651  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.415177  2892 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:24.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.415720  2892 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:24.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.416368  2892 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.447250  2892 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
17:13:24.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.447540  2892 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.447726  2892 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
17:13:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.447916  2892 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
17:13:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.448129  2892 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
17:13:24.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.448300  2892 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45947/jwks.json
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.483980  2892 master_runner.cc:386] Master server non-default flags:
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:24.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.252:39241
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45947/jwks.json
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data/info.pb
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.252
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:24.485 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/logs
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:24.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:24.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:24.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:24.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:24.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:24.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.485379  2892 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:24.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.487574  2892 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:24.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.507095  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 4
17:13:24.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.509747  2903 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
17:13:24.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.512063  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.615665  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } attempt: 7
17:13:24.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.632614  2815 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } has no permanent_uuid. Determining permanent_uuid...
17:13:24.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.637840  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.696305  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 1
17:13:24.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.701529  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.782896  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 2
17:13:24.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.787272  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.811517  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 5
17:13:24.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.816287  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:24.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.872668  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 3
17:13:24.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.876920  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:25.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.017398  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 4
17:13:25.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:25.022181  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:25.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.305558  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 5
17:13:25.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:25.310611  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:25.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.363657  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 6
17:13:25.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:25.370654  2890 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:24.512758  2892 server_base.cc:1034] running on GCE node
17:13:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.511849  2902 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
17:13:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:24.511560  2905 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
17:13:25.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.727882  2892 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.730736  2892 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:25.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.732205  2892 hybrid_clock.cc:648] HybridClock initialized: now 1783530805732119 us; error 41 us; skew 500 ppm
17:13:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.733155  2892 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:25.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.739817  2892 webserver.cc:460] Webserver started at http://127.2.171.252:39141/ using document root <none> and password file <none>
17:13:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.740914  2892 fs_manager.cc:359] Metadata directory not provided
17:13:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.741163  2892 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.741704  2892 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.746814  2892 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data/instance:
17:13:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ecc8f64c7287469091ebd460a3a644ea"
17:13:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:25 on dist-test-slave-r7jh"
17:13:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.748102  2892 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal/instance:
17:13:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ecc8f64c7287469091ebd460a3a644ea"
17:13:25.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:25 on dist-test-slave-r7jh"
17:13:25.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.755978  2892 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.002s	sys 0.005s
17:13:25.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.761770  2916 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:25.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.763450  2892 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.003s
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.763739  2892 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ecc8f64c7287469091ebd460a3a644ea"
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:25 on dist-test-slave-r7jh"
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.764050  2892 fs_report.cc:383] FS layout report
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data/data
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:25.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:25.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:25.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.803875  2892 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:25.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.805336  2892 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
17:13:25.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.805716  2892 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:25.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.863008  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 6
17:13:25.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:25.870168  2815 consensus_peers.cc:646] Error getting permanent uuid from config peer 127.2.171.252:39241: Network error: Client connection negotiation failed: client connection to 127.2.171.252:39241: connect: Connection refused (error 111)
17:13:25.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.886656  2892 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.252:39241
17:13:25.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.886741  2969 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.252:39241 every 8 connection(s)
17:13:25.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.890297  2892 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/data/info.pb
17:13:25.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.894615  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 2892
17:13:25.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.895045  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/master-2/wal/instance
17:13:25.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.897639  2970 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:25.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.916765  2970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } has no permanent_uuid. Determining permanent_uuid...
17:13:25.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.952297  2970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } has no permanent_uuid. Determining permanent_uuid...
17:13:25.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.966428  2970 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } has no permanent_uuid. Determining permanent_uuid...
17:13:25.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.988525  2970 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: Bootstrap starting.
17:13:25.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.995018  2970 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: Neither blocks nor log segments found. Creating new log.
17:13:25.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:25.997141  2970 log.cc:824] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: Log is configured to *not* fsync() on all Append() calls
17:13:26.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.001915  2970 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: No bootstrap required, opened a new log
17:13:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.024706  2970 raft_consensus.cc:348] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.026132  2970 raft_consensus.cc:374] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.026440  2970 raft_consensus.cc:729] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ecc8f64c7287469091ebd460a3a644ea, State: Initialized, Role: FOLLOWER
17:13:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.027364  2970 consensus_queue.cc:260] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.030036  2979 sys_catalog.cc:455] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.030640  2979 sys_catalog.cc:458] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: This master's current role is: FOLLOWER
17:13:26.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.031560  2970 sys_catalog.cc:564] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: configured and running, proceeding with master startup.
17:13:26.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.032676  2979 raft_consensus.cc:482] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
17:13:26.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.032998  2979 raft_consensus.cc:504] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.035643  2979 leader_election.cc:288] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 17f7c399c7b749c7bc7bd021361be57a (127.2.171.254:42715), 2883dc84bc0b446794a685ae8f3d4a53 (127.2.171.253:33691)
17:13:26.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:26.064595  2922 tablet.cc:2369] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: Can't schedule compaction. Clean time has not been advanced past its initial value.
17:13:26.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:26.071727  2990 catalog_manager.cc:1558] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
17:13:26.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:26.074995  2990 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
17:13:26.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.059903  2892 master_runner.cc:186] Error getting master registration for 127.2.171.254:42715: OK, instance_id { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" instance_seqno: 1783530802247238 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
17:13:26.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.102335  2892 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
17:13:26.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.431308  2890 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 7
17:13:26.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.466656  2890 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: Bootstrap starting.
17:13:26.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.471868  2890 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: Neither blocks nor log segments found. Creating new log.
17:13:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.473950  2890 log.cc:824] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: Log is configured to *not* fsync() on all Append() calls
17:13:26.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.478526  2890 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: No bootstrap required, opened a new log
17:13:26.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.508919  2890 raft_consensus.cc:348] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.509804  2890 raft_consensus.cc:374] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:26.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.510082  2890 raft_consensus.cc:729] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2883dc84bc0b446794a685ae8f3d4a53, State: Initialized, Role: FOLLOWER
17:13:26.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.510962  2890 consensus_queue.cc:260] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.514118  2994 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.515002  2994 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: This master's current role is: FOLLOWER
17:13:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.515930  2890 sys_catalog.cc:564] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: configured and running, proceeding with master startup.
17:13:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.516111  2865 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ecc8f64c7287469091ebd460a3a644ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2883dc84bc0b446794a685ae8f3d4a53" is_pre_election: true
17:13:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.516961  2865 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate ecc8f64c7287469091ebd460a3a644ea in term 0.
17:13:26.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.518973  2919 leader_election.cc:302] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 2883dc84bc0b446794a685ae8f3d4a53, ecc8f64c7287469091ebd460a3a644ea; no voters: 
17:13:26.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.519999  2979 raft_consensus.cc:2781] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Leader pre-election won for term 1
17:13:26.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.520380  2979 raft_consensus.cc:482] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
17:13:26.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.520713  2979 raft_consensus.cc:3037] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 0 FOLLOWER]: Advancing to term 1
17:13:26.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.529403  2979 raft_consensus.cc:504] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.541198  2979 leader_election.cc:288] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [CANDIDATE]: Term 1 election: Requested vote from peers 17f7c399c7b749c7bc7bd021361be57a (127.2.171.254:42715), 2883dc84bc0b446794a685ae8f3d4a53 (127.2.171.253:33691)
17:13:26.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.541508  2865 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ecc8f64c7287469091ebd460a3a644ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2883dc84bc0b446794a685ae8f3d4a53"
17:13:26.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.542264  2865 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 0 FOLLOWER]: Advancing to term 1
17:13:26.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.560009  2865 raft_consensus.cc:2454] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate ecc8f64c7287469091ebd460a3a644ea in term 1.
17:13:26.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.561535  2919 leader_election.cc:302] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [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: 2883dc84bc0b446794a685ae8f3d4a53, ecc8f64c7287469091ebd460a3a644ea; no voters: 
17:13:26.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.562265  2979 raft_consensus.cc:2781] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 1 FOLLOWER]: Leader election won for term 1
17:13:26.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.563853  2979 raft_consensus.cc:686] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [term 1 LEADER]: Becoming Leader. State: Replica: ecc8f64c7287469091ebd460a3a644ea, State: Running, Role: LEADER
17:13:26.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.564697  2979 consensus_queue.cc:237] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:26.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.573921  3005 sys_catalog.cc:455] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: SysCatalogTable state changed. Reason: New leader ecc8f64c7287469091ebd460a3a644ea. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.574652  3005 sys_catalog.cc:458] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: This master's current role is: LEADER
17:13:26.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.586985  3008 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
17:13:26.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.619324  3008 catalog_manager.cc:1484] Initializing Kudu cluster ID...
17:13:26.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:26.628474  3007 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
17:13:26.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:26.628834  3007 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
17:13:26.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.591068  2817 master_runner.cc:186] Error getting master registration for 127.2.171.254:42715: OK, instance_id { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" instance_seqno: 1783530802247238 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
17:13:26.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.645081  2817 master_runner.cc:418] Couldn't verify the masters in the cluster. Trying again...
17:13:26.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.655328  2865 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [term 1 FOLLOWER]: Refusing update from remote peer ecc8f64c7287469091ebd460a3a644ea: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
17:13:26.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.657158  2979 consensus_queue.cc:1035] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [LEADER]: Connected to new peer: Peer: permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
17:13:26.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.687101  2994 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ecc8f64c7287469091ebd460a3a644ea. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.693219  2994 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: This master's current role is: FOLLOWER
17:13:26.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.702491  3005 sys_catalog.cc:455] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.703357  3005 sys_catalog.cc:458] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: This master's current role is: LEADER
17:13:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.707178  3008 catalog_manager.cc:1347] Generated new cluster ID: 4623d6d3f0b64e6789840d1af633d51e
17:13:26.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.707490  3008 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
17:13:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.711459  2994 sys_catalog.cc:455] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:26.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.712258  2994 sys_catalog.cc:458] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53 [sys.catalog]: This master's current role is: FOLLOWER
17:13:26.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.770936  3008 catalog_manager.cc:1370] Generated new certificate authority record
17:13:26.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.773886  3008 catalog_manager.cc:1504] Loading token signing keys...
17:13:26.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.812062  3008 catalog_manager.cc:5868] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea: Generated new TSK 0
17:13:26.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.816463  3008 catalog_manager.cc:1514] Initializing in-progress tserver states...
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.857476  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/logs
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data/info.pb
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:26.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.193:0
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.193
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.193
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:26.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
17:13:26.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.903548  2815 consensus_peers.cc:656] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } attempt: 7
17:13:26.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.953881  2815 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: Bootstrap starting.
17:13:26.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.972370  2815 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: Neither blocks nor log segments found. Creating new log.
17:13:26.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.975718  2815 log.cc:824] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: Log is configured to *not* fsync() on all Append() calls
17:13:26.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:26.994472  2815 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: No bootstrap required, opened a new log
17:13:27.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.061326  2815 raft_consensus.cc:348] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:27.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.062202  2815 raft_consensus.cc:374] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:27.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.062489  2815 raft_consensus.cc:729] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 17f7c399c7b749c7bc7bd021361be57a, State: Initialized, Role: FOLLOWER
17:13:27.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.063369  2815 consensus_queue.cc:260] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } }
17:13:27.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.073607  3018 sys_catalog.cc:455] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [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: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:27.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.074432  3018 sys_catalog.cc:458] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: This master's current role is: FOLLOWER
17:13:27.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.078466  2815 sys_catalog.cc:564] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: configured and running, proceeding with master startup.
17:13:27.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.088876  2788 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [term 0 FOLLOWER]: Advancing to term 1
17:13:27.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.089864  2790 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ecc8f64c7287469091ebd460a3a644ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "17f7c399c7b749c7bc7bd021361be57a" is_pre_election: true
17:13:27.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.090605  2789 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "ecc8f64c7287469091ebd460a3a644ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "17f7c399c7b749c7bc7bd021361be57a"
17:13:27.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.096448  2790 rpcz_store.cc:275] Call kudu.consensus.ConsensusService.RequestConsensusVote from 127.0.0.1:34214 (request call id 1) took 1059 ms. Trace:
17:13:27.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.098146  2790 rpcz_store.cc:276] 0708 17:13:26.036736 (+     0us) service_pool.cc:170] Inserting onto call queue
17:13:27.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 17:13:26.036882 (+   146us) service_pool.cc:227] Handling call
17:13:27.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 17:13:27.096389 (+1059507us) inbound_call.cc:173] Queueing success response
17:13:27.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {}
17:13:27.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.113246  2788 raft_consensus.cc:1261] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [term 1 FOLLOWER]: Refusing update from remote peer ecc8f64c7287469091ebd460a3a644ea: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
17:13:27.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.115886  2979 consensus_queue.cc:1035] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [LEADER]: Connected to new peer: Peer: permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.004s
17:13:27.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.211354  3018 sys_catalog.cc:455] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: SysCatalogTable state changed. Reason: New leader ecc8f64c7287469091ebd460a3a644ea. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:27.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.211954  3029 sys_catalog.cc:455] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:27.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.212890  3029 sys_catalog.cc:458] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: This master's current role is: FOLLOWER
17:13:27.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.212615  3018 sys_catalog.cc:458] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a [sys.catalog]: This master's current role is: FOLLOWER
17:13:27.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.223445  3034 catalog_manager.cc:795] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
17:13:27.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.555852  3015 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:27.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.557315  3015 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:27.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.558094  3015 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:27.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.602722  3040 sys_catalog.cc:455] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "ecc8f64c7287469091ebd460a3a644ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "17f7c399c7b749c7bc7bd021361be57a" member_type: VOTER last_known_addr { host: "127.2.171.254" port: 42715 } } peers { permanent_uuid: "2883dc84bc0b446794a685ae8f3d4a53" member_type: VOTER last_known_addr { host: "127.2.171.253" port: 33691 } } peers { permanent_uuid: "ecc8f64c7287469091ebd460a3a644ea" member_type: VOTER last_known_addr { host: "127.2.171.252" port: 39241 } } }
17:13:27.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.603919  3040 sys_catalog.cc:458] T 00000000000000000000000000000000 P ecc8f64c7287469091ebd460a3a644ea [sys.catalog]: This master's current role is: LEADER
17:13:27.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.613989  3015 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:27.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.615432  3015 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.171.193
17:13:27.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.634579  3007 catalog_manager.cc:1259] Loaded cluster ID: 4623d6d3f0b64e6789840d1af633d51e
17:13:27.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.635273  3007 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: loading cluster ID for follower catalog manager: success
17:13:27.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.653780  3007 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: acquiring CA information for follower catalog manager: success
17:13:27.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.659677  3007 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 2883dc84bc0b446794a685ae8f3d4a53: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.669589  3015 tablet_server_runner.cc:78] Tablet server non-default flags:
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.193:0
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data/info.pb
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.193
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:27.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.193
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/logs
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:27.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.671128  3015 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:27.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.672971  3015 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:27.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.699247  3044 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
17:13:28.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:28.249902  3034 catalog_manager.cc:1259] Loaded cluster ID: 4623d6d3f0b64e6789840d1af633d51e
17:13:28.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:28.260322  3034 catalog_manager.cc:1552] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: loading cluster ID for follower catalog manager: success
17:13:28.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:28.300397  3034 catalog_manager.cc:1574] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: acquiring CA information for follower catalog manager: success
17:13:28.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:28.332942  3034 catalog_manager.cc:1602] T 00000000000000000000000000000000 P 17f7c399c7b749c7bc7bd021361be57a: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
17:13:29.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:27.704695  3015 server_base.cc:1034] running on GCE node
17:13:29.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.704212  3047 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
17:13:29.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:27.703796  3043 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
17:13:29.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.257078  3015 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:29.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.260792  3015 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:29.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.262243  3015 hybrid_clock.cc:648] HybridClock initialized: now 1783530809262168 us; error 87 us; skew 500 ppm
17:13:29.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.263401  3015 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:29.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.296919  3015 webserver.cc:460] Webserver started at http://127.2.171.193:37971/ using document root <none> and password file <none>
17:13:29.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.298357  3015 fs_manager.cc:359] Metadata directory not provided
17:13:29.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.298633  3015 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:29.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.299188  3015 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:29.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.306806  3015 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data/instance:
17:13:29.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c2750509d45d4b168f5a6719a978c242"
17:13:29.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:29 on dist-test-slave-r7jh"
17:13:29.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.308406  3015 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal/instance:
17:13:29.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c2750509d45d4b168f5a6719a978c242"
17:13:29.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:29 on dist-test-slave-r7jh"
17:13:29.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.318542  3015 fs_manager.cc:691] Time spent creating directory manager: real 0.009s	user 0.007s	sys 0.002s
17:13:29.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.327873  3054 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:29.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.329355  3015 fs_manager.cc:725] Time spent opening block manager: real 0.006s	user 0.005s	sys 0.001s
17:13:29.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.329766  3015 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal
17:13:29.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c2750509d45d4b168f5a6719a978c242"
17:13:29.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:29 on dist-test-slave-r7jh"
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.330217  3015 fs_report.cc:383] FS layout report
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data/data
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:29.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:29.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.408470  3015 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:29.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.410560  3015 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
17:13:29.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.411146  3015 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:29.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.415098  3015 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
17:13:29.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.421335  3015 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
17:13:29.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.421646  3015 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
17:13:29.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.421974  3015 ts_tablet_manager.cc:610] Registered 0 tablets
17:13:29.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.422191  3015 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
17:13:29.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.607906  3015 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.193:39761
17:13:29.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.608111  3166 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.193:39761 every 8 connection(s)
17:13:29.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.610713  3015 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/data/info.pb
17:13:29.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.614711  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 3015
17:13:29.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.615204  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-0/wal/instance
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.635445  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:29.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/logs
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data/info.pb
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.194:0
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.194
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.194
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:29.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
17:13:29.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.663981  3167 heartbeater.cc:347] Connected to a master server at 127.2.171.252:39241
17:13:29.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.664649  3167 heartbeater.cc:464] Registering TS with master...
17:13:29.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.665936  3167 heartbeater.cc:511] Master 127.2.171.252:39241 requested a full tablet report, sending...
17:13:29.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.669550  2933 ts_manager.cc:194] Registered new tserver with Master: c2750509d45d4b168f5a6719a978c242 (127.2.171.193:39761)
17:13:29.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.673861  2933 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.171.193:56821
17:13:29.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.702483  3168 heartbeater.cc:347] Connected to a master server at 127.2.171.253:33691
17:13:29.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.703341  3168 heartbeater.cc:464] Registering TS with master...
17:13:29.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.704216  3168 heartbeater.cc:511] Master 127.2.171.253:33691 requested a full tablet report, sending...
17:13:29.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.704422  3169 heartbeater.cc:347] Connected to a master server at 127.2.171.254:42715
17:13:29.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.704758  3169 heartbeater.cc:464] Registering TS with master...
17:13:29.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.705497  3169 heartbeater.cc:511] Master 127.2.171.254:42715 requested a full tablet report, sending...
17:13:29.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.708484  2855 ts_manager.cc:194] Registered new tserver with Master: c2750509d45d4b168f5a6719a978c242 (127.2.171.193:39761)
17:13:29.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:29.709988  2780 ts_manager.cc:194] Registered new tserver with Master: c2750509d45d4b168f5a6719a978c242 (127.2.171.193:39761)
17:13:30.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.020927  3176 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:30.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.021561  3176 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:30.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.022156  3176 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:30.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.054205  3176 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:30.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.055008  3176 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.171.194
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:30.110901  3176 tablet_server_runner.cc:78] Tablet server non-default flags:
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal
17:13:30.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.194:0
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data/info.pb
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.194
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:30.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.194
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/logs
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:30.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:30.112519  3176 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:30.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:30.114609  3176 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:30.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.142897  3183 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
17:13:30.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:30.679812  3167 heartbeater.cc:503] Master 127.2.171.252:39241 was elected leader, sending a full tablet report...
17:13:31.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.146278  3182 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
17:13:31.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:30.146811  3176 server_base.cc:1034] running on GCE node
17:13:31.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:30.145152  3185 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
17:13:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.389720  3176 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:31.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.392004  3176 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:31.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.393445  3176 hybrid_clock.cc:648] HybridClock initialized: now 1783530811393405 us; error 46 us; skew 500 ppm
17:13:31.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.394254  3176 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:31.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.400254  3176 webserver.cc:460] Webserver started at http://127.2.171.194:45319/ using document root <none> and password file <none>
17:13:31.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.401204  3176 fs_manager.cc:359] Metadata directory not provided
17:13:31.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.401438  3176 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:31.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.401930  3176 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.406723  3176 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data/instance:
17:13:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1074d29d8dc9486ca8bcc7e38556da6f"
17:13:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:31 on dist-test-slave-r7jh"
17:13:31.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.407866  3176 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal/instance:
17:13:31.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1074d29d8dc9486ca8bcc7e38556da6f"
17:13:31.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:31 on dist-test-slave-r7jh"
17:13:31.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.414681  3176 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
17:13:31.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.420101  3194 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:31.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.421248  3176 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.000s
17:13:31.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.421594  3176 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1074d29d8dc9486ca8bcc7e38556da6f"
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:31 on dist-test-slave-r7jh"
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.421967  3176 fs_report.cc:383] FS layout report
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data/data
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:31.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:31.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:31.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:31.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:31.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.453387  3176 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:31.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.454962  3176 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
17:13:31.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.455520  3176 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:31.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.458367  3176 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
17:13:31.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.463220  3176 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
17:13:31.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.463475  3176 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
17:13:31.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.463780  3176 ts_tablet_manager.cc:610] Registered 0 tablets
17:13:31.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.463977  3176 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
17:13:31.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.617858  3176 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.194:36833
17:13:31.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.618000  3306 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.194:36833 every 8 connection(s)
17:13:31.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.621924  3176 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/data/info.pb
17:13:31.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.629977  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 3176
17:13:31.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.630906  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-1/wal/instance
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.652539  2735 external_mini_cluster.cc:1326] Running /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task3YOomn/build/tsan/bin/kudu
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/logs
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data/info.pb
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
17:13:31.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.195:0
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.195
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.195
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:31.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
17:13:31.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.677400  3307 heartbeater.cc:347] Connected to a master server at 127.2.171.252:39241
17:13:31.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.678231  3307 heartbeater.cc:464] Registering TS with master...
17:13:31.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.678455  3308 heartbeater.cc:347] Connected to a master server at 127.2.171.253:33691
17:13:31.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.678843  3308 heartbeater.cc:464] Registering TS with master...
17:13:31.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.679433  3307 heartbeater.cc:511] Master 127.2.171.252:39241 requested a full tablet report, sending...
17:13:31.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.680011  3308 heartbeater.cc:511] Master 127.2.171.253:33691 requested a full tablet report, sending...
17:13:31.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.682150  2933 ts_manager.cc:194] Registered new tserver with Master: 1074d29d8dc9486ca8bcc7e38556da6f (127.2.171.194:36833)
17:13:31.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.682636  2855 ts_manager.cc:194] Registered new tserver with Master: 1074d29d8dc9486ca8bcc7e38556da6f (127.2.171.194:36833)
17:13:31.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.684206  2933 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.171.194:53383
17:13:31.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.688417  3309 heartbeater.cc:347] Connected to a master server at 127.2.171.254:42715
17:13:31.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.688751  3309 heartbeater.cc:464] Registering TS with master...
17:13:31.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.689636  3309 heartbeater.cc:511] Master 127.2.171.254:42715 requested a full tablet report, sending...
17:13:31.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:31.692431  2780 ts_manager.cc:194] Registered new tserver with Master: 1074d29d8dc9486ca8bcc7e38556da6f (127.2.171.194:36833)
17:13:31.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:31.997044  3317 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
17:13:31.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:31.997524  3317 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
17:13:31.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:31.997979  3317 flags.cc:425] Enabled unsafe flag: --never_fsync=true
17:13:32.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:32.029614  3317 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
17:13:32.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:32.030531  3317 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.2.171.195
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:32.066075  3317 tablet_server_runner.cc:78] Tablet server non-default flags:
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.2.171.212:36487
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.2.171.195:0
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data/info.pb
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.2.171.195
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.2.171.254:42715,127.2.171.253:33691,127.2.171.252:39241
17:13:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.2.171.195
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/logs
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 16:08:30 UTC on ccycloud.quasar-mtkpji.root.comops.site
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493844
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
17:13:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:32.067389  3317 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
17:13:32.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:32.069432  3317 file_cache.cc:493] Constructed file cache file cache with capacity 419430
17:13:32.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:32.092759  3326 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
17:13:32.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:32.689872  3307 heartbeater.cc:503] Master 127.2.171.252:39241 was elected leader, sending a full tablet report...
17:13:33.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:32.094663  3323 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
17:13:33.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:32.093143  3324 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
17:13:33.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:33.318841  3325 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Connection time-out
17:13:33.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.318853  3317 server_base.cc:1029] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
17:13:33.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.322840  3317 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
17:13:33.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.325104  3317 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
17:13:33.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.326622  3317 hybrid_clock.cc:648] HybridClock initialized: now 1783530813326591 us; error 50 us; skew 500 ppm
17:13:33.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.327365  3317 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
17:13:33.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.333853  3317 webserver.cc:460] Webserver started at http://127.2.171.195:33281/ using document root <none> and password file <none>
17:13:33.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.334718  3317 fs_manager.cc:359] Metadata directory not provided
17:13:33.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.334903  3317 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
17:13:33.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.335264  3317 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
17:13:33.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.340008  3317 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data/instance:
17:13:33.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3143f55c47a147e8bf4c6fe9090fd1f1"
17:13:33.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:33 on dist-test-slave-r7jh"
17:13:33.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.341354  3317 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal/instance:
17:13:33.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3143f55c47a147e8bf4c6fe9090fd1f1"
17:13:33.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:33 on dist-test-slave-r7jh"
17:13:33.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.348966  3317 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.000s
17:13:33.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.354219  3334 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
17:13:33.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.355293  3317 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.004s
17:13:33.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.355583  3317 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data,/tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal
17:13:33.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3143f55c47a147e8bf4c6fe9090fd1f1"
17:13:33.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 17:13:33 on dist-test-slave-r7jh"
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.355952  3317 fs_report.cc:383] FS layout report
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data/data
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
17:13:33.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
17:13:33.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.397389  3317 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
17:13:33.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.398862  3317 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
17:13:33.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.399276  3317 kserver.cc:163] Server-wide thread pool size limit: 3276
17:13:33.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.401682  3317 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
17:13:33.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.405827  3317 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
17:13:33.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.406070  3317 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
17:13:33.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.406260  3317 ts_tablet_manager.cc:610] Registered 0 tablets
17:13:33.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.406391  3317 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
17:13:33.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.561846  3317 rpc_server.cc:307] RPC server started. Bound to: 127.2.171.195:42017
17:13:33.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.561946  3446 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.2.171.195:42017 every 8 connection(s)
17:13:33.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.564446  3317 server_base.cc:1166] Dumped server information to /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/data/info.pb
17:13:33.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.570008  2735 external_mini_cluster.cc:1388] Started /tmp/dist-test-task3YOomn/build/tsan/bin/kudu as pid 3317
17:13:33.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.570508  2735 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task3YOomn/test-tmp/mini-kudu-cluster2878257938399656694/ts-2/wal/instance
17:13:33.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.628732  3447 heartbeater.cc:347] Connected to a master server at 127.2.171.252:39241
17:13:33.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.629241  3447 heartbeater.cc:464] Registering TS with master...
17:13:33.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.630529  3447 heartbeater.cc:511] Master 127.2.171.252:39241 requested a full tablet report, sending...
17:13:33.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.632823  3448 heartbeater.cc:347] Connected to a master server at 127.2.171.253:33691
17:13:33.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.633137  3448 heartbeater.cc:464] Registering TS with master...
17:13:33.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.633229  2932 ts_manager.cc:194] Registered new tserver with Master: 3143f55c47a147e8bf4c6fe9090fd1f1 (127.2.171.195:42017)
17:13:33.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.634140  3448 heartbeater.cc:511] Master 127.2.171.253:33691 requested a full tablet report, sending...
17:13:33.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.635353  2932 master_service.cc:496] Signed X509 certificate for tserver {username='slave'} at 127.2.171.195:60715
17:13:33.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.636855  2855 ts_manager.cc:194] Registered new tserver with Master: 3143f55c47a147e8bf4c6fe9090fd1f1 (127.2.171.195:42017)
17:13:33.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.640046  3449 heartbeater.cc:347] Connected to a master server at 127.2.171.254:42715
17:13:33.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.640416  3449 heartbeater.cc:464] Registering TS with master...
17:13:33.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.641045  3449 heartbeater.cc:511] Master 127.2.171.254:42715 requested a full tablet report, sending...
17:13:33.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.643309  2780 ts_manager.cc:194] Registered new tserver with Master: 3143f55c47a147e8bf4c6fe9090fd1f1 (127.2.171.195:42017)
17:13:33.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:33.646508  2735 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
17:13:33.657 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
17:13:33.659 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

17:13:33.670 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.171.254"
      port: 42715
    }
    bound_http_address {
      host: "127.2.171.254"
      port: 46413
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.171.253"
      port: 33691
    }
    bound_http_address {
      host: "127.2.171.253"
      port: 40449
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.171.252"
      port: 39241
    }
    bound_http_address {
      host: "127.2.171.252"
      port: 39141
    }
  }
}

17:13:33.674 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

17:13:33.676 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.2.171.193"
      port: 39761
    }
    bound_http_address {
      host: "127.2.171.193"
      port: 37971
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.2.171.194"
      port: 36833
    }
    bound_http_address {
      host: "127.2.171.194"
      port: 45319
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.2.171.195"
      port: 42017
    }
    bound_http_address {
      host: "127.2.171.195"
      port: 33281
    }
  }
}

17:13:33.676 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
17:13:33.861 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
17:13:34.029 [DEBUG - main] (Connection.java:748) [peer master-127.2.171.253:33691(127.2.171.253:33691)] connecting to peer
17:13:34.087 [DEBUG - main] (Connection.java:748) [peer master-127.2.171.252:39241(127.2.171.252:39241)] connecting to peer
17:13:34.099 [DEBUG - main] (Connection.java:748) [peer master-127.2.171.254:42715(127.2.171.254:42715)] connecting to peer
17:13:34.131 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.2.171.252:39241(127.2.171.252:39241)] Successfully connected to peer
17:13:34.136 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.171.253:33691(127.2.171.253:33691)] Successfully connected to peer
17:13:34.205 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.2.171.254:42715(127.2.171.254:42715)] Successfully connected to peer
17:13:34.233 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.171.253
17:13:34.233 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.171.252
17:13:34.338 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.2.171.254
17:13:34.476 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x40328886, L:/127.0.0.1:56582 - R:/127.2.171.252:39241] using SASL/PLAIN
17:13:34.476 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x58298d07, L:/127.0.0.1:47934 - R:/127.2.171.253:33691] using SASL/PLAIN
17:13:34.497 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x5e26bcba, L:/127.0.0.1:45672 - R:/127.2.171.254:42715] using SASL/PLAIN
17:13:34.521 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
17:13:34.523 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=533), Traces: [0ms] refreshing cache from master, [28ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.171.253:33691, [94ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.171.252:39241, [106ms] Sub RPC ConnectToMaster: sending RPC to server master-127.2.171.254:42715, [497ms] Sub RPC ConnectToMaster: received response from server master-127.2.171.253:33691: OK, [498ms] Sub RPC ConnectToMaster: received response from server master-127.2.171.252:39241: OK, [508ms] Sub RPC ConnectToMaster: received response from server master-127.2.171.254:42715: OK, deferred=null) after lookup
17:13:34.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.597543  2933 catalog_manager.cc:1908] Servicing CreateTable request from {username='slave'} at 127.0.0.1:56582:
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783530799896"
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
17:13:34.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
17:13:34.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:34.601742  2933 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-1783530799896 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
17:13:34.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.641068  3447 heartbeater.cc:503] Master 127.2.171.252:39241 was elected leader, sending a full tablet report...
17:13:34.690 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 434b0e6c6a204543989b4313b641fa8f
17:13:34.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.703240  3102 tablet_service.cc:1467] Processing CreateTablet for tablet 1e56fbe49dad46e884c2720056338095 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783530799896 [id=434b0e6c6a204543989b4313b641fa8f]), partition=RANGE (key) PARTITION UNBOUNDED
17:13:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.705477  3102 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 1e56fbe49dad46e884c2720056338095. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:34.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.709797  3382 tablet_service.cc:1467] Processing CreateTablet for tablet 1e56fbe49dad46e884c2720056338095 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783530799896 [id=434b0e6c6a204543989b4313b641fa8f]), partition=RANGE (key) PARTITION UNBOUNDED
17:13:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.713172  3242 tablet_service.cc:1467] Processing CreateTablet for tablet 1e56fbe49dad46e884c2720056338095 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783530799896 [id=434b0e6c6a204543989b4313b641fa8f]), partition=RANGE (key) PARTITION UNBOUNDED
17:13:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.714999  3242 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 1e56fbe49dad46e884c2720056338095. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:34.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.717620  3382 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 1e56fbe49dad46e884c2720056338095. 1 dirs total, 0 dirs full, 0 dirs failed
17:13:34.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.742215  3479 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Bootstrap starting.
17:13:34.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.743119  3480 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Bootstrap starting.
17:13:34.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.748827  3479 tablet_bootstrap.cc:654] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Neither blocks nor log segments found. Creating new log.
17:13:34.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.750204  3480 tablet_bootstrap.cc:654] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Neither blocks nor log segments found. Creating new log.
17:13:34.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.751984  3479 log.cc:824] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Log is configured to *not* fsync() on all Append() calls
17:13:34.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.754164  3480 log.cc:824] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Log is configured to *not* fsync() on all Append() calls
17:13:34.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.759187  3479 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: No bootstrap required, opened a new log
17:13:34.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.759857  3482 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Bootstrap starting.
17:13:34.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.759920  3479 ts_tablet_manager.cc:1397] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Time spent bootstrapping tablet: real 0.018s	user 0.015s	sys 0.000s
17:13:34.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.760073  3480 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: No bootstrap required, opened a new log
17:13:34.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.760591  3480 ts_tablet_manager.cc:1397] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Time spent bootstrapping tablet: real 0.018s	user 0.008s	sys 0.007s
17:13:34.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.766861  3482 tablet_bootstrap.cc:654] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Neither blocks nor log segments found. Creating new log.
17:13:34.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.769500  3482 log.cc:824] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Log is configured to *not* fsync() on all Append() calls
17:13:34.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.781553  3482 tablet_bootstrap.cc:492] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: No bootstrap required, opened a new log
17:13:34.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.782099  3482 ts_tablet_manager.cc:1397] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Time spent bootstrapping tablet: real 0.023s	user 0.012s	sys 0.008s
17:13:34.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.788120  3480 raft_consensus.cc:348] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.788856  3480 raft_consensus.cc:374] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:34.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.789165  3480 raft_consensus.cc:729] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1074d29d8dc9486ca8bcc7e38556da6f, State: Initialized, Role: FOLLOWER
17:13:34.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.790547  3480 consensus_queue.cc:260] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [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: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.793290  3479 raft_consensus.cc:348] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.794593  3479 raft_consensus.cc:374] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:34.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.794874  3479 raft_consensus.cc:729] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c2750509d45d4b168f5a6719a978c242, State: Initialized, Role: FOLLOWER
17:13:34.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.795742  3479 consensus_queue.cc:260] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [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: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.802691  3480 ts_tablet_manager.cc:1428] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Time spent starting tablet: real 0.042s	user 0.028s	sys 0.008s
17:13:34.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.813355  3479 ts_tablet_manager.cc:1428] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Time spent starting tablet: real 0.053s	user 0.030s	sys 0.019s
17:13:34.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.825320  3482 raft_consensus.cc:348] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.826203  3482 raft_consensus.cc:374] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
17:13:34.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.826542  3482 raft_consensus.cc:729] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3143f55c47a147e8bf4c6fe9090fd1f1, State: Initialized, Role: FOLLOWER
17:13:34.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.827353  3482 consensus_queue.cc:260] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [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: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.830601  3482 ts_tablet_manager.cc:1428] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Time spent starting tablet: real 0.048s	user 0.037s	sys 0.004s
17:13:34.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:34.851673  3454 tablet.cc:2369] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1: Can't schedule compaction. Clean time has not been advanced past its initial value.
17:13:34.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:34.892436  3310 tablet.cc:2369] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f: Can't schedule compaction. Clean time has not been advanced past its initial value.
17:13:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 17:13:34.954176  3172 tablet.cc:2369] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242: Can't schedule compaction. Clean time has not been advanced past its initial value.
17:13:34.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.958832  3487 raft_consensus.cc:482] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
17:13:34.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.959344  3487 raft_consensus.cc:504] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.962256  3487 leader_election.cc:288] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers c2750509d45d4b168f5a6719a978c242 (127.2.171.193:39761), 1074d29d8dc9486ca8bcc7e38556da6f (127.2.171.194:36833)
17:13:34.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.976259  3262 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "1e56fbe49dad46e884c2720056338095" candidate_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" is_pre_election: true
17:13:34.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.976619  3122 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "1e56fbe49dad46e884c2720056338095" candidate_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c2750509d45d4b168f5a6719a978c242" is_pre_election: true
17:13:34.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.977197  3262 raft_consensus.cc:2454] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3143f55c47a147e8bf4c6fe9090fd1f1 in term 0.
17:13:34.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.977475  3122 raft_consensus.cc:2454] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3143f55c47a147e8bf4c6fe9090fd1f1 in term 0.
17:13:34.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.978540  3338 leader_election.cc:302] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 1074d29d8dc9486ca8bcc7e38556da6f, 3143f55c47a147e8bf4c6fe9090fd1f1; no voters: 
17:13:34.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.979372  3487 raft_consensus.cc:2781] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Leader pre-election won for term 1
17:13:34.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.979666  3487 raft_consensus.cc:482] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
17:13:34.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.979897  3487 raft_consensus.cc:3037] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 0 FOLLOWER]: Advancing to term 1
17:13:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.984992  3487 raft_consensus.cc:504] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:34.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.986383  3487 leader_election.cc:288] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [CANDIDATE]: Term 1 election: Requested vote from peers c2750509d45d4b168f5a6719a978c242 (127.2.171.193:39761), 1074d29d8dc9486ca8bcc7e38556da6f (127.2.171.194:36833)
17:13:34.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.987277  3122 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "1e56fbe49dad46e884c2720056338095" candidate_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c2750509d45d4b168f5a6719a978c242"
17:13:34.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.987403  3262 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "1e56fbe49dad46e884c2720056338095" candidate_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "1074d29d8dc9486ca8bcc7e38556da6f"
17:13:34.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.987757  3122 raft_consensus.cc:3037] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 0 FOLLOWER]: Advancing to term 1
17:13:34.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.987888  3262 raft_consensus.cc:3037] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 0 FOLLOWER]: Advancing to term 1
17:13:34.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.993243  3262 raft_consensus.cc:2454] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3143f55c47a147e8bf4c6fe9090fd1f1 in term 1.
17:13:34.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.994375  3338 leader_election.cc:302] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [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: 1074d29d8dc9486ca8bcc7e38556da6f, 3143f55c47a147e8bf4c6fe9090fd1f1; no voters: 
17:13:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.993883  3122 raft_consensus.cc:2454] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3143f55c47a147e8bf4c6fe9090fd1f1 in term 1.
17:13:34.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.995057  3487 raft_consensus.cc:2781] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 1 FOLLOWER]: Leader election won for term 1
17:13:34.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.997066  3487 raft_consensus.cc:686] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [term 1 LEADER]: Becoming Leader. State: Replica: 3143f55c47a147e8bf4c6fe9090fd1f1, State: Running, Role: LEADER
17:13:34.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:34.997959  3487 consensus_queue.cc:237] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [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: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } }
17:13:35.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.010566  2933 catalog_manager.cc:5495] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 reported cstate change: term changed from 0 to 1, leader changed from <none> to 3143f55c47a147e8bf4c6fe9090fd1f1 (127.2.171.195). New cstate: current_term: 1 leader_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "3143f55c47a147e8bf4c6fe9090fd1f1" member_type: VOTER last_known_addr { host: "127.2.171.195" port: 42017 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 } health_report { overall_health: UNKNOWN } } }
17:13:35.233 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 1e56fbe49dad46e884c2720056338095 for table 'org.apache.kudu.client.TestHybridTime-1783530799896' with partition [<start>, <end>)
17:13:35.240 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=1e56fbe49dad46e884c2720056338095@[1074d29d8dc9486ca8bcc7e38556da6f(127.2.171.194:36833),3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)[L],c2750509d45d4b168f5a6719a978c242(127.2.171.193:39761)]}]
17:13:35.242 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=20), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.2.171.252:39241, [9ms] Sub RPC GetTableLocations: received response from server master-127.2.171.252:39241: OK, deferred=null) after lookup
17:13:35.252 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)] connecting to peer
17:13:35.253 [DEBUG - kudu-nio-1] (Connection.java:757) [peer 3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)] Successfully connected to peer
17:13:35.309 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x69882e62, L:/127.0.0.1:44514 - R:/127.2.171.195:42017] using TOKEN/null
17:13:35.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.324090  3262 raft_consensus.cc:1261] T 1e56fbe49dad46e884c2720056338095 P 1074d29d8dc9486ca8bcc7e38556da6f [term 1 FOLLOWER]: Refusing update from remote peer 3143f55c47a147e8bf4c6fe9090fd1f1: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
17:13:35.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.324095  3122 raft_consensus.cc:1261] T 1e56fbe49dad46e884c2720056338095 P c2750509d45d4b168f5a6719a978c242 [term 1 FOLLOWER]: Refusing update from remote peer 3143f55c47a147e8bf4c6fe9090fd1f1: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
17:13:35.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.325807  3487 consensus_queue.cc:1035] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [LEADER]: Connected to new peer: Peer: permanent_uuid: "c2750509d45d4b168f5a6719a978c242" member_type: VOTER last_known_addr { host: "127.2.171.193" port: 39761 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
17:13:35.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.327282  3487 consensus_queue.cc:1035] T 1e56fbe49dad46e884c2720056338095 P 3143f55c47a147e8bf4c6fe9090fd1f1 [LEADER]: Connected to new peer: Peer: permanent_uuid: "1074d29d8dc9486ca8bcc7e38556da6f" member_type: VOTER last_known_addr { host: "127.2.171.194" port: 36833 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
17:13:35.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.351203  3495 mvcc.cc:205] Tried to move back new op lower bound from 7305342219549241344 to 7305342218238590976. Current Snapshot: MvccSnapshot[applied={T|T < 7305342219549241344}]
17:13:35.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.388346  3500 mvcc.cc:205] Tried to move back new op lower bound from 7305342219549241344 to 7305342218238590976. Current Snapshot: MvccSnapshot[applied={T|T < 7305342219549241344}]
17:13:35.417 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.441 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.456 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.460 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1468414020(state=PENDING, result=null, callback=<none>, errback=<none>)}
17:13:35.479 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.480 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@315925145(state=PENDING, result=null, callback=<none>, errback=<none>)}
17:13:35.500 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.501 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@716672852(state=PENDING, result=null, callback=<none>, errback=<none>)}
17:13:35.516 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
17:13:35.563 [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-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.577 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305342240029241345) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.590 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305342240029241348) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.605 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305342240029241352) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.619 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305342240029241356) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.631 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305342240029241360) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.649 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305342240029241364) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.661 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305342240029241365) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783530799896, tablet=1e56fbe49dad46e884c2720056338095, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
17:13:35.676 [DEBUG - main] (Connection.java:575) [peer master-127.2.171.252:39241(127.2.171.252:39241)] disconnecting while in state READY
17:13:35.678 [DEBUG - main] (Connection.java:575) [peer 3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)] disconnecting while in state READY
17:13:35.678 [DEBUG - main] (Connection.java:575) [peer master-127.2.171.254:42715(127.2.171.254:42715)] disconnecting while in state READY
17:13:35.678 [DEBUG - main] (Connection.java:575) [peer master-127.2.171.253:33691(127.2.171.253:33691)] disconnecting while in state READY
17:13:35.690 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.2.171.252:39241(127.2.171.252:39241)] handling channelInactive
17:13:35.691 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.2.171.252:39241(127.2.171.252:39241)] cleaning up while in state READY due to: connection closed
17:13:35.691 [DEBUG - kudu-nio-1] (Connection.java:239) [peer 3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)] handling channelInactive
17:13:35.691 [DEBUG - kudu-nio-1] (Connection.java:709) [peer 3143f55c47a147e8bf4c6fe9090fd1f1(127.2.171.195:42017)] cleaning up while in state READY due to: connection closed
17:13:35.694 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
17:13:35.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.700980  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 3015
17:13:35.705 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.171.254:42715(127.2.171.254:42715)] handling channelInactive
17:13:35.705 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.171.254:42715(127.2.171.254:42715)] cleaning up while in state READY due to: connection closed
17:13:35.705 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.2.171.253:33691(127.2.171.253:33691)] handling channelInactive
17:13:35.706 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.2.171.253:33691(127.2.171.253:33691)] cleaning up while in state READY due to: connection closed
17:13:35.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.734496  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 3176
17:13:35.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.763849  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 3317
17:13:35.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.799614  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 2747
17:13:35.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.827132  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 2817
17:13:35.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 17:13:35.852857  2735 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task3YOomn/build/tsan/bin/kudu with pid 2892
17:13:37.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T17:13:37Z chronyd exiting

Time: 18.372

OK (1 test)

