JUnit version 4.13.2
.02:03:39.547 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783476219537
02:03:39.574 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
02:03:39.611 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
02:03:39.621 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskmTODK9/test-tmp
02:03:39.651 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
02:03:39.653 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskmTODK9/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
02:03:39.857 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

02:03:40.102 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:03:40.103 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

02:03:40.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.106871 21057 mini_oidc.cc:150] Starting JWKS server
02:03:40.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.109654 21057 webserver.cc:534] Webserver started at http://127.0.0.1:40311/ using document root <none> and password file <none>
02:03:40.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.109978 21057 mini_oidc.cc:186] Starting OIDC Discovery server
02:03:40.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.111404 21057 webserver.cc:534] Webserver started at http://127.0.0.1:42695/ using document root <none> and password file <none>
02:03:40.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:03:40Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
02:03:40.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:03:40Z Disabled control of system clock
02:03:40.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.140846 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:40.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:40.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal
02:03:40.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data
02:03:40.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:40.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:40.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:40.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:40.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:40.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:40.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/logs
02:03:40.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data/info.pb
02:03:40.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:40.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:40.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:40.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:40.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:40.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:40.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:40.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:40.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:40.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:40.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:40.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:40.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.126:40767
02:03:40.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.126
02:03:40.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:40.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:40.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:40.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:40.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:40.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:40.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:40.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:40.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json with env {}
02:03:40.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.493552 21068 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:40.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.494057 21068 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:40.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.494179 21068 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:40.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.507658 21068 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:40.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.507791 21068 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:40.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.507877 21068 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:40.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.507942 21068 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:40.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.508018 21068 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:40.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.508065 21068 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40311/jwks.json
02:03:40.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.524169 21068 master_runner.cc:387] Master server non-default flags:
02:03:40.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:40.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:40.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:40.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:40.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data
02:03:40.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal
02:03:40.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:40.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.126:40767
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:40.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json
02:03:40.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:40.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:40.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data/info.pb
02:03:40.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.126
02:03:40.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:40.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:40.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:40.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:40.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:40.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:40.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/logs
02:03:40.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:40.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:40.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:40.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:40.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:40.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:40.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:40.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:40.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:40.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:40.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.526402 21068 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:40.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.528340 21068 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:40.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.537438 21073 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
02:03:40.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.537405 21074 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
02:03:40.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.538829 21068 server_base.cc:1061] running on GCE node
02:03:40.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.537585 21076 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
02:03:40.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.540072 21068 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:40.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.541694 21068 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:40.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.542933 21068 hybrid_clock.cc:648] HybridClock initialized: now 1783476220542867 us; error 56 us; skew 500 ppm
02:03:40.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.543411 21068 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:40.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.545934 21068 webserver.cc:534] Webserver started at http://127.20.144.126:35187/ using document root <none> and password file <none>
02:03:40.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.546880 21068 fs_manager.cc:362] Metadata directory not provided
02:03:40.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.547027 21068 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:40.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.547505 21068 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:40.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.550151 21068 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data/instance:
02:03:40.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52"
02:03:40.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:40 on dist-test-slave-qh7f"
02:03:40.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.551165 21068 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal/instance:
02:03:40.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52"
02:03:40.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:40 on dist-test-slave-qh7f"
02:03:40.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.557231 21068 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
02:03:40.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.561337 21082 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:40.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.562999 21068 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.003s
02:03:40.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.563165 21068 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal
02:03:40.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52"
02:03:40.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:40 on dist-test-slave-qh7f"
02:03:40.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.563367 21068 fs_report.cc:389] FS layout report
02:03:40.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:40.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal
02:03:40.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal
02:03:40.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data/data
02:03:40.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:40.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:40.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:40.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:40.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:40.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:40.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:40.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:40.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:40.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:40.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:40.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.618544 21068 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:40.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.619500 21068 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:40.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.619757 21068 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:40.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.641520 21068 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.126:40767
02:03:40.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.641537 21133 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.126:40767 every 8 connection(s)
02:03:40.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.643397 21068 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/data/info.pb
02:03:40.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.648137 21134 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:40.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.650300 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21068
02:03:40.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.650712 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-0/wal/instance
02:03:40.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.653855 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:40.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:40.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal
02:03:40.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data
02:03:40.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/logs
02:03:40.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data/info.pb
02:03:40.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:40.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:40.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:40.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:40.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:40.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.125:37777
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.125
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:40.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:40.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:40.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:40.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:40.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:40.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json with env {}
02:03:40.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.657675 21134 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } has no permanent_uuid. Determining permanent_uuid...
02:03:40.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.675699 21134 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } has no permanent_uuid. Determining permanent_uuid...
02:03:40.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.676954 21086 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:40.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.678696 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.125:37777: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:40.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.728120 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } attempt: 1
02:03:40.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.730537 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.125:37777: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:40.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.798861 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } attempt: 2
02:03:40.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.801771 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.125:37777: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:40.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:40.893093 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } attempt: 3
02:03:40.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:40.898487 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.125:37777: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:41.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.006085 21136 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:41.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.006453 21136 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:41.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.006541 21136 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:41.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015408 21136 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:41.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015529 21136 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:41.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015585 21136 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:41.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015631 21136 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:41.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015692 21136 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:41.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.015728 21136 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40311/jwks.json
02:03:41.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.032497 21136 master_runner.cc:387] Master server non-default flags:
02:03:41.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:41.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:41.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:41.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.125:37777
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data/info.pb
02:03:41.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.125
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/logs
02:03:41.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:41.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:41.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:41.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:41.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.034812 21136 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:41.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.037338 21136 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:41.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.041808 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } attempt: 4
02:03:41.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.043929 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.125:37777: Network error: Client connection negotiation failed: client connection to 127.20.144.125:37777: connect: Connection refused (error 111)
02:03:41.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.046738 21144 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
02:03:41.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.048409 21145 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
02:03:41.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.054062 21147 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
02:03:41.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.054972 21136 server_base.cc:1061] running on GCE node
02:03:41.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.056203 21136 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:41.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.058373 21136 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:41.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.059631 21136 hybrid_clock.cc:648] HybridClock initialized: now 1783476221059574 us; error 61 us; skew 500 ppm
02:03:41.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.060076 21136 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.062755 21136 webserver.cc:534] Webserver started at http://127.20.144.125:34843/ using document root <none> and password file <none>
02:03:41.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.063656 21136 fs_manager.cc:362] Metadata directory not provided
02:03:41.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.063776 21136 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:41.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.064190 21136 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:41.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.066967 21136 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data/instance:
02:03:41.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "071b993a03e6470a97d8ab038adce009"
02:03:41.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.067878 21136 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal/instance:
02:03:41.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "071b993a03e6470a97d8ab038adce009"
02:03:41.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.074008 21136 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.004s	sys 0.004s
02:03:41.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.077817 21153 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.079398 21136 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.001s
02:03:41.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.079587 21136 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "071b993a03e6470a97d8ab038adce009"
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.079772 21136 fs_report.cc:389] FS layout report
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal
02:03:41.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data/data
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:41.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:41.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.114727 21136 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:41.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.115670 21136 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:41.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.115948 21136 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:41.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.138581 21136 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.125:37777
02:03:41.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.138602 21204 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.125:37777 every 8 connection(s)
02:03:41.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.140100 21136 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/data/info.pb
02:03:41.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.144850 21205 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:41.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.145079 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21136
02:03:41.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.145238 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-1/wal/instance
02:03:41.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.146711 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:41.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:41.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:41.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:41.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:41.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/logs
02:03:41.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data/info.pb
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:41.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.124:43865
02:03:41.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.124
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:41.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:41.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json with env {}
02:03:41.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.156189 21205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.174469 21205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.184528 21205 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.186034 21154 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.187978 21205 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.237326 21205 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 1
02:03:41.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.239514 21205 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.307821 21205 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 2
02:03:41.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.310149 21205 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.343232 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } attempt: 5
02:03:41.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.349848 21134 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.351884 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.401450 21205 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 3
02:03:41.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.403102 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 1
02:03:41.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.403770 21205 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.405298 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.473569 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 2
02:03:41.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.475695 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.504968 21207 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:41.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.505312 21207 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:41.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.505393 21207 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514019 21207 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514127 21207 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514185 21207 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514231 21207 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:41.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514285 21207 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:41.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.514355 21207 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:40311/jwks.json
02:03:41.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.525244 21207 master_runner.cc:387] Master server non-default flags:
02:03:41.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:41.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.124:43865
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:40311/jwks.json
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:41.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data/info.pb
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.124
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:41.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/logs
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:41.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:41.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:41.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.527107 21207 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:41.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.529657 21207 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:41.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.539531 21218 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
02:03:41.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.539608 21216 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
02:03:41.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.539623 21215 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
02:03:41.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.540678 21207 server_base.cc:1061] running on GCE node
02:03:41.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.541762 21207 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:41.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.543289 21207 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:41.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.544631 21207 hybrid_clock.cc:648] HybridClock initialized: now 1783476221544517 us; error 33 us; skew 500 ppm
02:03:41.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.545145 21207 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:41.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.547019 21205 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 4
02:03:41.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.548027 21207 webserver.cc:534] Webserver started at http://127.20.144.124:35823/ using document root <none> and password file <none>
02:03:41.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.548966 21205 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.549127 21207 fs_manager.cc:362] Metadata directory not provided
02:03:41.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.549232 21207 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:41.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.549587 21207 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:41.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.552204 21207 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data/instance:
02:03:41.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3b14fe41ec849fda04c64fdf0029fcd"
02:03:41.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.553118 21207 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal/instance:
02:03:41.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3b14fe41ec849fda04c64fdf0029fcd"
02:03:41.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.559243 21207 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
02:03:41.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.564318 21224 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.566155 21207 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.002s
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.566339 21207 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3b14fe41ec849fda04c64fdf0029fcd"
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:41 on dist-test-slave-qh7f"
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.566552 21207 fs_report.cc:389] FS layout report
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:41.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data/data
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:41.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:41.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:41.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:41.568 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:41.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.581995 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 3
02:03:41.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.584090 21134 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.20.144.124:43865: Network error: Client connection negotiation failed: client connection to 127.20.144.124:43865: connect: Connection refused (error 111)
02:03:41.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.615792 21207 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:41.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.616731 21207 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:41.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.616964 21207 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.638245 21207 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.124:43865
02:03:41.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.638273 21275 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.124:43865 every 8 connection(s)
02:03:41.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.639803 21207 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/data/info.pb
02:03:41.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.642918 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21207
02:03:41.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.643112 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/master-2/wal/instance
02:03:41.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.645128 21276 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:41.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.653429 21276 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.667922 21276 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.675177 21276 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } has no permanent_uuid. Determining permanent_uuid...
02:03:41.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.686421 21276 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: Bootstrap starting.
02:03:41.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.690071 21276 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: Neither blocks nor log segments found. Creating new log.
02:03:41.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.691150 21276 log.cc:826] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: Log is configured to *not* fsync() on all Append() calls
02:03:41.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.693883 21276 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: No bootstrap required, opened a new log
02:03:41.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.699532 21276 raft_consensus.cc:359] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.699985 21276 raft_consensus.cc:385] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:41.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.700125 21276 raft_consensus.cc:740] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d3b14fe41ec849fda04c64fdf0029fcd, State: Initialized, Role: FOLLOWER
02:03:41.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.700963 21276 consensus_queue.cc:260] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.702227 21284 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.702524 21284 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.703233 21276 sys_catalog.cc:565] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: configured and running, proceeding with master startup.
02:03:41.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.711783 21207 master_runner.cc:187] Error getting master registration for 127.20.144.126:40767: OK, instance_id { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" instance_seqno: 1783476220635627 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:03:41.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.716114 21207 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:03:41.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.718861 21295 catalog_manager.cc:1593] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:03:41.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.719383 21295 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:03:41.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.731469 21284 raft_consensus.cc:493] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:03:41.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.731714 21284 raft_consensus.cc:515] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.733302 21284 leader_election.cc:290] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 50e8fdd4662f47c4b2f4dbba4e0e9a52 (127.20.144.126:40767), 071b993a03e6470a97d8ab038adce009 (127.20.144.125:37777)
02:03:41.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.761304 21134 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 4
02:03:41.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.774339 21134 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: Bootstrap starting.
02:03:41.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.779184 21134 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: Neither blocks nor log segments found. Creating new log.
02:03:41.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.780478 21134 log.cc:826] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: Log is configured to *not* fsync() on all Append() calls
02:03:41.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.783881 21134 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: No bootstrap required, opened a new log
02:03:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.790499 21134 raft_consensus.cc:359] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.790823 21134 raft_consensus.cc:385] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:41.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.790946 21134 raft_consensus.cc:740] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 50e8fdd4662f47c4b2f4dbba4e0e9a52, State: Initialized, Role: FOLLOWER
02:03:41.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.791687 21134 consensus_queue.cc:260] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.797 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.797358 21298 sys_catalog.cc:455] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.797745 21298 sys_catalog.cc:458] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.798810 21134 sys_catalog.cc:565] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: configured and running, proceeding with master startup.
02:03:41.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.798823 21109 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" is_pre_election: true
02:03:41.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.799882 21109 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d3b14fe41ec849fda04c64fdf0029fcd in term 0.
02:03:41.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.800806 21226 leader_election.cc:304] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [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: 50e8fdd4662f47c4b2f4dbba4e0e9a52, d3b14fe41ec849fda04c64fdf0029fcd; no voters: 
02:03:41.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.801390 21284 raft_consensus.cc:2804] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Leader pre-election won for term 1
02:03:41.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.801573 21284 raft_consensus.cc:493] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:03:41.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.801704 21284 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 0 FOLLOWER]: Advancing to term 1
02:03:41.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.806478 21284 raft_consensus.cc:515] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.809878 21109 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52"
02:03:41.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.810134 21109 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 0 FOLLOWER]: Advancing to term 1
02:03:41.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.810356 21284 leader_election.cc:290] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [CANDIDATE]: Term 1 election: Requested vote from peers 50e8fdd4662f47c4b2f4dbba4e0e9a52 (127.20.144.126:40767), 071b993a03e6470a97d8ab038adce009 (127.20.144.125:37777)
02:03:41.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.828420 21109 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d3b14fe41ec849fda04c64fdf0029fcd in term 1.
02:03:41.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.830010 21226 leader_election.cc:304] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [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: 50e8fdd4662f47c4b2f4dbba4e0e9a52, d3b14fe41ec849fda04c64fdf0029fcd; no voters: 
02:03:41.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.830518 21284 raft_consensus.cc:2804] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 1 FOLLOWER]: Leader election won for term 1
02:03:41.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.831841 21284 raft_consensus.cc:697] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [term 1 LEADER]: Becoming Leader. State: Replica: d3b14fe41ec849fda04c64fdf0029fcd, State: Running, Role: LEADER
02:03:41.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.832625 21284 consensus_queue.cc:237] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.838317 21307 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: SysCatalogTable state changed. Reason: New leader d3b14fe41ec849fda04c64fdf0029fcd. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.838766 21307 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: This master's current role is: LEADER
02:03:41.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.840238 21311 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
02:03:41.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.843283 21311 catalog_manager.cc:1519] Initializing Kudu cluster ID...
02:03:41.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.848264 21205 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } attempt: 5
02:03:41.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.856956 21312 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:03:41.858 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.857719 21312 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:03:41.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.863433 21109 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [term 1 FOLLOWER]: Refusing update from remote peer d3b14fe41ec849fda04c64fdf0029fcd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:03:41.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.864611 21307 consensus_queue.cc:1048] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [LEADER]: Connected to new peer: Peer: permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:03:41.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.854043 21068 master_runner.cc:187] Error getting master registration for 127.20.144.125:37777: OK, instance_id { permanent_uuid: "071b993a03e6470a97d8ab038adce009" instance_seqno: 1783476221132759 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:03:41.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.866767 21068 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:03:41.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.869122 21230 tablet.cc:2406] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:03:41.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.871831 21205 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: Bootstrap starting.
02:03:41.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:41.872799 21088 tablet.cc:2406] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:03:41.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.877758 21205 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: Neither blocks nor log segments found. Creating new log.
02:03:41.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.879444 21205 log.cc:826] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: Log is configured to *not* fsync() on all Append() calls
02:03:41.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.890172 21205 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: No bootstrap required, opened a new log
02:03:41.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.898452 21205 raft_consensus.cc:359] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.898859 21205 raft_consensus.cc:385] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:41.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.898988 21205 raft_consensus.cc:740] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 071b993a03e6470a97d8ab038adce009, State: Initialized, Role: FOLLOWER
02:03:41.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.900115 21205 consensus_queue.cc:260] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } }
02:03:41.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.905609 21298 sys_catalog.cc:455] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: SysCatalogTable state changed. Reason: New leader d3b14fe41ec849fda04c64fdf0029fcd. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.905895 21298 sys_catalog.cc:458] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.906314 21313 mvcc.cc:204] Tried to move back new op lower bound from 7305118604733739008 to 7305118604633767936. Current Snapshot: MvccSnapshot[applied={T|T < 7305118604733739008}]
02:03:41.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.908522 21315 mvcc.cc:204] Tried to move back new op lower bound from 7305118604733739008 to 7305118604633767936. Current Snapshot: MvccSnapshot[applied={T|T < 7305118604733739008}]
02:03:41.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.919739 21284 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.920063 21284 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: This master's current role is: LEADER
02:03:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.921164 21298 sys_catalog.cc:455] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.921444 21298 sys_catalog.cc:458] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52 [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.921684 21311 catalog_manager.cc:1382] Generated new cluster ID: 68204ee4bfd445e68a2af9a205945df7
02:03:41.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.921782 21311 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
02:03:41.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.937986 21318 sys_catalog.cc:455] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [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: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.938446 21318 sys_catalog.cc:458] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.940752 21205 sys_catalog.cc:565] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: configured and running, proceeding with master startup.
02:03:41.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.941229 21178 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [term 0 FOLLOWER]: Advancing to term 1
02:03:41.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.945281 21180 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "071b993a03e6470a97d8ab038adce009" is_pre_election: true
02:03:41.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.952733 21179 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "071b993a03e6470a97d8ab038adce009"
02:03:41.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.956257 21178 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [term 1 FOLLOWER]: Refusing update from remote peer d3b14fe41ec849fda04c64fdf0029fcd: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:03:41.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.957603 21284 consensus_queue.cc:1048] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [LEADER]: Connected to new peer: Peer: permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:03:41.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.958946 21311 catalog_manager.cc:1405] Generated new certificate authority record
02:03:41.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.960793 21311 catalog_manager.cc:1539] Loading token signing keys...
02:03:41.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.975656 21311 catalog_manager.cc:6069] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd: Generated new TSK 0
02:03:41.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.977095 21311 catalog_manager.cc:1549] Initializing in-progress tserver states...
02:03:41.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.993753 21318 sys_catalog.cc:455] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: SysCatalogTable state changed. Reason: New leader d3b14fe41ec849fda04c64fdf0029fcd. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.994028 21318 sys_catalog.cc:458] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: This master's current role is: FOLLOWER
02:03:41.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.995076 21325 sys_catalog.cc:455] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:41.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.995651 21325 sys_catalog.cc:458] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009 [sys.catalog]: This master's current role is: FOLLOWER
02:03:42.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.997352 21307 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "50e8fdd4662f47c4b2f4dbba4e0e9a52" member_type: VOTER last_known_addr { host: "127.20.144.126" port: 40767 } } peers { permanent_uuid: "071b993a03e6470a97d8ab038adce009" member_type: VOTER last_known_addr { host: "127.20.144.125" port: 37777 } } peers { permanent_uuid: "d3b14fe41ec849fda04c64fdf0029fcd" member_type: VOTER last_known_addr { host: "127.20.144.124" port: 43865 } } }
02:03:42.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:41.997593 21307 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3b14fe41ec849fda04c64fdf0029fcd [sys.catalog]: This master's current role is: LEADER
02:03:42.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.008472 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/logs
02:03:42.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data/info.pb
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:42.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.65:0
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.65
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.65
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:42.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:03:42.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.135015 21338 catalog_manager.cc:1294] Loaded cluster ID: 68204ee4bfd445e68a2af9a205945df7
02:03:42.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.135666 21338 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: loading cluster ID for follower catalog manager: success
02:03:42.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.144109 21338 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: acquiring CA information for follower catalog manager: success
02:03:42.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.147320 21338 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 071b993a03e6470a97d8ab038adce009: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:03:42.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.549808 21330 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:42.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.550925 21330 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:42.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.551129 21330 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:42.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.565635 21330 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:42.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.566582 21330 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.144.65
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.584477 21330 tablet_server_runner.cc:78] Tablet server non-default flags:
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:42.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.65:0
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data/info.pb
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.65
02:03:42.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.65
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/logs
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:42.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:42.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:42.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.591012 21330 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:42.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.594192 21330 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:42.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.607182 21346 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
02:03:42.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.609048 21347 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
02:03:42.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:42.618275 21349 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
02:03:42.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.618988 21330 server_base.cc:1061] running on GCE node
02:03:42.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.619853 21330 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:42.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.621272 21330 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:42.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.622850 21330 hybrid_clock.cc:648] HybridClock initialized: now 1783476222622731 us; error 117 us; skew 500 ppm
02:03:42.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.623276 21330 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:42.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.626675 21330 webserver.cc:534] Webserver started at http://127.20.144.65:35545/ using document root <none> and password file <none>
02:03:42.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.627481 21330 fs_manager.cc:362] Metadata directory not provided
02:03:42.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.627583 21330 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:42.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.627885 21330 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.630666 21330 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data/instance:
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de6657ae498d4059a604ab1fc87da05e"
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:42 on dist-test-slave-qh7f"
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.631496 21330 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal/instance:
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de6657ae498d4059a604ab1fc87da05e"
02:03:42.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:42 on dist-test-slave-qh7f"
02:03:42.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.638125 21330 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
02:03:42.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.645329 21355 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:42.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.647523 21330 fs_manager.cc:730] Time spent opening block manager: real 0.007s	user 0.001s	sys 0.003s
02:03:42.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.648095 21330 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal
02:03:42.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "de6657ae498d4059a604ab1fc87da05e"
02:03:42.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:42 on dist-test-slave-qh7f"
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.648813 21330 fs_report.cc:389] FS layout report
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data/data
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:42.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:42.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:42.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:42.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.714380 21330 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:42.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.715369 21330 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:42.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.715646 21330 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:42.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.716703 21330 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:03:42.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.718451 21330 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:03:42.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.718546 21330 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:03:42.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.718621 21330 ts_tablet_manager.cc:616] Registered 0 tablets
02:03:42.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.718668 21330 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:03:42.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.754671 21330 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.65:37897
02:03:42.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.754737 21467 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.65:37897 every 8 connection(s)
02:03:42.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.756366 21330 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/data/info.pb
02:03:42.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.763342 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21330
02:03:42.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.763607 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-0/wal/instance
02:03:42.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.775130 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:42.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:42.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/logs
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data/info.pb
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:42.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.66:0
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.66
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.66
02:03:42.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:42.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:03:42.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801357 21468 heartbeater.cc:344] Connected to a master server at 127.20.144.124:43865
02:03:42.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801406 21470 heartbeater.cc:344] Connected to a master server at 127.20.144.125:37777
02:03:42.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801617 21469 heartbeater.cc:344] Connected to a master server at 127.20.144.126:40767
02:03:42.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801803 21469 heartbeater.cc:461] Registering TS with master...
02:03:42.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801808 21470 heartbeater.cc:461] Registering TS with master...
02:03:42.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.801810 21468 heartbeater.cc:461] Registering TS with master...
02:03:42.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.802845 21470 heartbeater.cc:507] Master 127.20.144.125:37777 requested a full tablet report, sending...
02:03:42.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.802907 21469 heartbeater.cc:507] Master 127.20.144.126:40767 requested a full tablet report, sending...
02:03:42.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.803359 21468 heartbeater.cc:507] Master 127.20.144.124:43865 requested a full tablet report, sending...
02:03:42.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.805675 21241 ts_manager.cc:194] Registered new tserver with Master: de6657ae498d4059a604ab1fc87da05e (127.20.144.65:37897)
02:03:42.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.805671 21170 ts_manager.cc:194] Registered new tserver with Master: de6657ae498d4059a604ab1fc87da05e (127.20.144.65:37897)
02:03:42.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.805691 21098 ts_manager.cc:194] Registered new tserver with Master: de6657ae498d4059a604ab1fc87da05e (127.20.144.65:37897)
02:03:42.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.808173 21241 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.144.65:35679
02:03:42.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.860323 21312 catalog_manager.cc:1294] Loaded cluster ID: 68204ee4bfd445e68a2af9a205945df7
02:03:42.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.860433 21312 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: loading cluster ID for follower catalog manager: success
02:03:42.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.863209 21312 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: acquiring CA information for follower catalog manager: success
02:03:42.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:42.865171 21312 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 50e8fdd4662f47c4b2f4dbba4e0e9a52: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:03:43.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.154718 21478 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:43.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.155115 21478 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:43.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.155231 21478 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:43.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.165282 21478 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:43.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.165536 21478 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.144.66
02:03:43.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.176170 21478 tablet_server_runner.cc:78] Tablet server non-default flags:
02:03:43.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:43.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.66:0
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data/info.pb
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.66
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:43.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.66
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/logs
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:43.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:43.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:43.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:43.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:43.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.178516 21478 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:43.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.181077 21478 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:43.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.191147 21485 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
02:03:43.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.191183 21484 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
02:03:43.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.192103 21487 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
02:03:43.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.192503 21478 server_base.cc:1061] running on GCE node
02:03:43.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.193308 21478 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:43.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.199980 21478 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:43.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.201265 21478 hybrid_clock.cc:648] HybridClock initialized: now 1783476223201191 us; error 71 us; skew 500 ppm
02:03:43.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.201725 21478 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:43.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.204667 21478 webserver.cc:534] Webserver started at http://127.20.144.66:38211/ using document root <none> and password file <none>
02:03:43.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.205636 21478 fs_manager.cc:362] Metadata directory not provided
02:03:43.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.205780 21478 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:43.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.206247 21478 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:43.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.209175 21478 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data/instance:
02:03:43.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d66ffc0fd334ff2adccf7237ef9d113"
02:03:43.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.209955 21478 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal/instance:
02:03:43.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d66ffc0fd334ff2adccf7237ef9d113"
02:03:43.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.215904 21478 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
02:03:43.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.219846 21493 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:43.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.221446 21478 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
02:03:43.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.221652 21478 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5d66ffc0fd334ff2adccf7237ef9d113"
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.221895 21478 fs_report.cc:389] FS layout report
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data/data
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:43.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:43.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:43.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:43.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:43.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.241153 21478 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:43.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.242290 21478 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:43.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.242628 21478 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:43.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.243754 21478 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:03:43.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.245653 21478 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:03:43.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.245793 21478 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:03:43.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.245899 21478 ts_tablet_manager.cc:616] Registered 0 tablets
02:03:43.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.245973 21478 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:03:43.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.281901 21478 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.66:44903
02:03:43.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.281961 21605 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.66:44903 every 8 connection(s)
02:03:43.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.283552 21478 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/data/info.pb
02:03:43.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.285862 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21478
02:03:43.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.286054 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-1/wal/instance
02:03:43.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.292313 21057 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:43.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskmTODK9/build/asan/bin/kudu
02:03:43.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal
02:03:43.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data
02:03:43.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/logs
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data/info.pb
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.67:0
02:03:43.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.67
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.67
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:43.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:03:43.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.304853 21608 heartbeater.cc:344] Connected to a master server at 127.20.144.125:37777
02:03:43.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.305312 21608 heartbeater.cc:461] Registering TS with master...
02:03:43.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.306424 21608 heartbeater.cc:507] Master 127.20.144.125:37777 requested a full tablet report, sending...
02:03:43.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.307476 21606 heartbeater.cc:344] Connected to a master server at 127.20.144.124:43865
02:03:43.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.307614 21606 heartbeater.cc:461] Registering TS with master...
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.308081 21606 heartbeater.cc:507] Master 127.20.144.124:43865 requested a full tablet report, sending...
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.308647 21170 ts_manager.cc:194] Registered new tserver with Master: 5d66ffc0fd334ff2adccf7237ef9d113 (127.20.144.66:44903)
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.309036 21607 heartbeater.cc:344] Connected to a master server at 127.20.144.126:40767
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.309163 21607 heartbeater.cc:461] Registering TS with master...
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.309201 21241 ts_manager.cc:194] Registered new tserver with Master: 5d66ffc0fd334ff2adccf7237ef9d113 (127.20.144.66:44903)
02:03:43.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.309666 21607 heartbeater.cc:507] Master 127.20.144.126:40767 requested a full tablet report, sending...
02:03:43.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.310446 21241 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.144.66:45149
02:03:43.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.310770 21098 ts_manager.cc:194] Registered new tserver with Master: 5d66ffc0fd334ff2adccf7237ef9d113 (127.20.144.66:44903)
02:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.647740 21613 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.648164 21613 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:43.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.648301 21613 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:43.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.657886 21613 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:43.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.658126 21613 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.20.144.67
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.668934 21613 tablet_server_runner.cc:78] Tablet server non-default flags:
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.20.144.84:35147
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data
02:03:43.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.20.144.67:0
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data/info.pb
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.20.144.67
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.20.144.126:40767,127.20.144.125:37777,127.20.144.124:43865
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.20.144.67
02:03:43.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/logs
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision a3f35afc2b6dad6aa403ec58378221544a26edd0
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 01:40:41 UTC on bdcb31816ec0
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16849
02:03:43.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
02:03:43.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.671396 21613 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
02:03:43.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.673833 21613 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:43.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.685318 21619 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
02:03:43.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.685273 21621 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
02:03:43.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:43.685230 21618 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
02:03:43.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.686282 21613 server_base.cc:1061] running on GCE node
02:03:43.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.687006 21613 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:43.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.688133 21613 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:43.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.689432 21613 hybrid_clock.cc:648] HybridClock initialized: now 1783476223689369 us; error 50 us; skew 500 ppm
02:03:43.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.689918 21613 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:43.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.692724 21613 webserver.cc:534] Webserver started at http://127.20.144.67:40817/ using document root <none> and password file <none>
02:03:43.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.693645 21613 fs_manager.cc:362] Metadata directory not provided
02:03:43.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.693801 21613 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:43.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.694347 21613 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:43.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.697333 21613 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data/instance:
02:03:43.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3da44ad1364b46febb4043e6764c4e2c"
02:03:43.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.698429 21613 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal/instance:
02:03:43.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3da44ad1364b46febb4043e6764c4e2c"
02:03:43.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.705338 21613 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
02:03:43.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.709677 21627 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:43.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.711333 21613 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
02:03:43.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.711582 21613 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data,/tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal
02:03:43.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3da44ad1364b46febb4043e6764c4e2c"
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 02:03:43 on dist-test-slave-qh7f"
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.711854 21613 fs_report.cc:389] FS layout report
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data/data
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:43.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:43.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:43.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:43.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.734364 21613 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:43.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.735559 21613 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
02:03:43.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.735919 21613 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:43.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.737159 21613 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:03:43.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.738895 21613 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:03:43.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.738991 21613 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:03:43.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.739065 21613 ts_tablet_manager.cc:616] Registered 0 tablets
02:03:43.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.739112 21613 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:03:43.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.775935 21613 rpc_server.cc:307] RPC server started. Bound to: 127.20.144.67:40337
02:03:43.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.775982 21739 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.20.144.67:40337 every 8 connection(s)
02:03:43.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.777501 21613 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/data/info.pb
02:03:43.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.787091 21057 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskmTODK9/build/asan/bin/kudu as pid 21613
02:03:43.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.787285 21057 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskmTODK9/test-tmp/mini-kudu-cluster12742290925123473640/ts-2/wal/instance
02:03:43.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.797719 21742 heartbeater.cc:344] Connected to a master server at 127.20.144.125:37777
02:03:43.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.798231 21742 heartbeater.cc:461] Registering TS with master...
02:03:43.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.798255 21740 heartbeater.cc:344] Connected to a master server at 127.20.144.124:43865
02:03:43.798 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.798454 21740 heartbeater.cc:461] Registering TS with master...
02:03:43.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.799288 21741 heartbeater.cc:344] Connected to a master server at 127.20.144.126:40767
02:03:43.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.799445 21741 heartbeater.cc:461] Registering TS with master...
02:03:43.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.799557 21740 heartbeater.cc:507] Master 127.20.144.124:43865 requested a full tablet report, sending...
02:03:43.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.799618 21742 heartbeater.cc:507] Master 127.20.144.125:37777 requested a full tablet report, sending...
02:03:43.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.800000 21741 heartbeater.cc:507] Master 127.20.144.126:40767 requested a full tablet report, sending...
02:03:43.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.801678 21098 ts_manager.cc:194] Registered new tserver with Master: 3da44ad1364b46febb4043e6764c4e2c (127.20.144.67:40337)
02:03:43.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.801752 21170 ts_manager.cc:194] Registered new tserver with Master: 3da44ad1364b46febb4043e6764c4e2c (127.20.144.67:40337)
02:03:43.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.802367 21241 ts_manager.cc:194] Registered new tserver with Master: 3da44ad1364b46febb4043e6764c4e2c (127.20.144.67:40337)
02:03:43.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.803284 21241 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.20.144.67:40061
02:03:43.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.811136 21468 heartbeater.cc:499] Master 127.20.144.124:43865 was elected leader, sending a full tablet report...
02:03:43.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:43.816041 21057 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
02:03:43.819 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:03:43.820 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

02:03:43.830 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.144.126"
      port: 40767
    }
    bound_http_address {
      host: "127.20.144.126"
      port: 35187
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.20.144.125"
      port: 37777
    }
    bound_http_address {
      host: "127.20.144.125"
      port: 34843
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.20.144.124"
      port: 43865
    }
    bound_http_address {
      host: "127.20.144.124"
      port: 35823
    }
  }
}

02:03:43.834 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

02:03:43.837 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.20.144.65"
      port: 37897
    }
    bound_http_address {
      host: "127.20.144.65"
      port: 35545
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.20.144.66"
      port: 44903
    }
    bound_http_address {
      host: "127.20.144.66"
      port: 38211
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.20.144.67"
      port: 40337
    }
    bound_http_address {
      host: "127.20.144.67"
      port: 40817
    }
  }
}

02:03:43.837 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
02:03:44.008 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
02:03:44.064 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
02:03:44.232 [DEBUG - main] (Connection.java:748) [peer master-127.20.144.124:43865(127.20.144.124:43865)] connecting to peer
02:03:44.289 [DEBUG - main] (Connection.java:748) [peer master-127.20.144.126:40767(127.20.144.126:40767)] connecting to peer
02:03:44.290 [DEBUG - main] (Connection.java:748) [peer master-127.20.144.125:37777(127.20.144.125:37777)] connecting to peer
02:03:44.310 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.20.144.124:43865(127.20.144.124:43865)] Successfully connected to peer
02:03:44.310 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.20.144.126:40767(127.20.144.126:40767)] Successfully connected to peer
02:03:44.310 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.20.144.125:37777(127.20.144.125:37777)] Successfully connected to peer
02:03:44.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.313182 21606 heartbeater.cc:499] Master 127.20.144.124:43865 was elected leader, sending a full tablet report...
02:03:44.401 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.144.126
02:03:44.401 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.144.125
02:03:44.401 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.20.144.124
02:03:44.637 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xbddb401d, L:/127.0.0.1:51974 - R:/127.20.144.125:37777] using SASL/PLAIN
02:03:44.640 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x8bf2fbec, L:/127.0.0.1:37920 - R:/127.20.144.124:43865] using SASL/PLAIN
02:03:44.648 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x61ea8a13, L:/127.0.0.1:57220 - R:/127.20.144.126:40767] using SASL/PLAIN
02:03:44.682 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
02:03:44.683 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=495), Traces: [0ms] refreshing cache from master, [31ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.144.124:43865, [98ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.144.126:40767, [99ms] Sub RPC ConnectToMaster: sending RPC to server master-127.20.144.125:37777, [468ms] Sub RPC ConnectToMaster: received response from server master-127.20.144.126:40767: OK, [468ms] Sub RPC ConnectToMaster: received response from server master-127.20.144.125:37777: OK, [469ms] Sub RPC ConnectToMaster: received response from server master-127.20.144.124:43865: OK, deferred=null) after lookup
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.729842 21241 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:37920:
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783476219427"
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
02:03:44.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:03:44.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:44.731690 21241 catalog_manager.cc:7076] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1783476219427 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
02:03:44.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.793767 21541 tablet_service.cc:1511] Processing CreateTablet for tablet a6baad1189904304a39a820d8ab1199c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476219427 [id=d1aa57144d8f499f8d35fd047b136374]), partition=RANGE (key) PARTITION UNBOUNDED
02:03:44.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.795231 21541 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet a6baad1189904304a39a820d8ab1199c. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:44.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.802898 21403 tablet_service.cc:1511] Processing CreateTablet for tablet a6baad1189904304a39a820d8ab1199c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476219427 [id=d1aa57144d8f499f8d35fd047b136374]), partition=RANGE (key) PARTITION UNBOUNDED
02:03:44.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.805112 21403 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet a6baad1189904304a39a820d8ab1199c. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:44.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.805787 21740 heartbeater.cc:499] Master 127.20.144.124:43865 was elected leader, sending a full tablet report...
02:03:44.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.812319 21675 tablet_service.cc:1511] Processing CreateTablet for tablet a6baad1189904304a39a820d8ab1199c (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783476219427 [id=d1aa57144d8f499f8d35fd047b136374]), partition=RANGE (key) PARTITION UNBOUNDED
02:03:44.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.814424 21675 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet a6baad1189904304a39a820d8ab1199c. 1 dirs total, 0 dirs full, 0 dirs failed
02:03:44.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.829408 21772 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Bootstrap starting.
02:03:44.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.831046 21773 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Bootstrap starting.
02:03:44.831 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table d1aa57144d8f499f8d35fd047b136374
02:03:44.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.835145 21773 tablet_bootstrap.cc:654] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Neither blocks nor log segments found. Creating new log.
02:03:44.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.836658 21773 log.cc:826] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Log is configured to *not* fsync() on all Append() calls
02:03:44.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.843974 21772 tablet_bootstrap.cc:654] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Neither blocks nor log segments found. Creating new log.
02:03:44.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.845986 21772 log.cc:826] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Log is configured to *not* fsync() on all Append() calls
02:03:44.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.846199 21775 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Bootstrap starting.
02:03:44.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.849269 21773 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: No bootstrap required, opened a new log
02:03:44.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.849673 21772 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: No bootstrap required, opened a new log
02:03:44.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.850006 21772 ts_tablet_manager.cc:1403] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Time spent bootstrapping tablet: real 0.021s	user 0.010s	sys 0.000s
02:03:44.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.850574 21773 ts_tablet_manager.cc:1403] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Time spent bootstrapping tablet: real 0.020s	user 0.007s	sys 0.009s
02:03:44.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.851452 21775 tablet_bootstrap.cc:654] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Neither blocks nor log segments found. Creating new log.
02:03:44.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.853199 21775 log.cc:826] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Log is configured to *not* fsync() on all Append() calls
02:03:44.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.858552 21773 raft_consensus.cc:359] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.859000 21773 raft_consensus.cc:385] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:44.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.859124 21773 raft_consensus.cc:740] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: de6657ae498d4059a604ab1fc87da05e, State: Initialized, Role: FOLLOWER
02:03:44.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.859937 21773 consensus_queue.cc:260] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [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: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.864887 21772 raft_consensus.cc:359] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.865974 21772 raft_consensus.cc:385] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:44.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.866358 21772 raft_consensus.cc:740] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5d66ffc0fd334ff2adccf7237ef9d113, State: Initialized, Role: FOLLOWER
02:03:44.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.867654 21772 consensus_queue.cc:260] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [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: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.870528 21772 ts_tablet_manager.cc:1434] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Time spent starting tablet: real 0.020s	user 0.013s	sys 0.000s
02:03:44.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.870540 21773 ts_tablet_manager.cc:1434] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Time spent starting tablet: real 0.020s	user 0.012s	sys 0.006s
02:03:44.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.874329 21775 tablet_bootstrap.cc:492] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: No bootstrap required, opened a new log
02:03:44.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.874924 21775 ts_tablet_manager.cc:1403] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Time spent bootstrapping tablet: real 0.029s	user 0.012s	sys 0.012s
02:03:44.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.882490 21775 raft_consensus.cc:359] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.882903 21775 raft_consensus.cc:385] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:03:44.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.883006 21775 raft_consensus.cc:740] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3da44ad1364b46febb4043e6764c4e2c, State: Initialized, Role: FOLLOWER
02:03:44.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.883685 21775 consensus_queue.cc:260] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [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: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.885555 21775 ts_tablet_manager.cc:1434] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Time spent starting tablet: real 0.010s	user 0.009s	sys 0.000s
02:03:44.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.905761 21778 raft_consensus.cc:493] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:03:44.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.906104 21778 raft_consensus.cc:515] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.908164 21778 leader_election.cc:290] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 3da44ad1364b46febb4043e6764c4e2c (127.20.144.67:40337), 5d66ffc0fd334ff2adccf7237ef9d113 (127.20.144.66:44903)
02:03:44.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.917642 21695 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "a6baad1189904304a39a820d8ab1199c" candidate_uuid: "de6657ae498d4059a604ab1fc87da05e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3da44ad1364b46febb4043e6764c4e2c" is_pre_election: true
02:03:44.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.917941 21561 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "a6baad1189904304a39a820d8ab1199c" candidate_uuid: "de6657ae498d4059a604ab1fc87da05e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" is_pre_election: true
02:03:44.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.918331 21695 raft_consensus.cc:2468] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate de6657ae498d4059a604ab1fc87da05e in term 0.
02:03:44.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.918386 21561 raft_consensus.cc:2468] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate de6657ae498d4059a604ab1fc87da05e in term 0.
02:03:44.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.919119 21357 leader_election.cc:304] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 3 responses out of 3 voters: 3 yes votes; 0 no votes. yes voters: 3da44ad1364b46febb4043e6764c4e2c, 5d66ffc0fd334ff2adccf7237ef9d113, de6657ae498d4059a604ab1fc87da05e; no voters: 
02:03:44.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.919551 21778 raft_consensus.cc:2804] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Leader pre-election won for term 1
02:03:44.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.919718 21778 raft_consensus.cc:493] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:03:44.919 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.919828 21778 raft_consensus.cc:3060] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 0 FOLLOWER]: Advancing to term 1
02:03:44.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.922042 21778 raft_consensus.cc:515] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.922734 21778 leader_election.cc:290] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [CANDIDATE]: Term 1 election: Requested vote from peers 3da44ad1364b46febb4043e6764c4e2c (127.20.144.67:40337), 5d66ffc0fd334ff2adccf7237ef9d113 (127.20.144.66:44903)
02:03:44.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.923175 21695 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "a6baad1189904304a39a820d8ab1199c" candidate_uuid: "de6657ae498d4059a604ab1fc87da05e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3da44ad1364b46febb4043e6764c4e2c"
02:03:44.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.923281 21561 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "a6baad1189904304a39a820d8ab1199c" candidate_uuid: "de6657ae498d4059a604ab1fc87da05e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5d66ffc0fd334ff2adccf7237ef9d113"
02:03:44.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.923398 21695 raft_consensus.cc:3060] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 0 FOLLOWER]: Advancing to term 1
02:03:44.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.923461 21561 raft_consensus.cc:3060] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 0 FOLLOWER]: Advancing to term 1
02:03:44.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.926753 21695 raft_consensus.cc:2468] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate de6657ae498d4059a604ab1fc87da05e in term 1.
02:03:44.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.926752 21561 raft_consensus.cc:2468] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate de6657ae498d4059a604ab1fc87da05e in term 1.
02:03:44.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.927246 21356 leader_election.cc:304] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [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: 5d66ffc0fd334ff2adccf7237ef9d113, de6657ae498d4059a604ab1fc87da05e; no voters: 
02:03:44.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.927618 21778 raft_consensus.cc:2804] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 1 FOLLOWER]: Leader election won for term 1
02:03:44.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.928082 21778 raft_consensus.cc:697] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [term 1 LEADER]: Becoming Leader. State: Replica: de6657ae498d4059a604ab1fc87da05e, State: Running, Role: LEADER
02:03:44.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.928720 21778 consensus_queue.cc:237] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [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: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } }
02:03:44.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:44.935045 21241 catalog_manager.cc:5696] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e reported cstate change: term changed from 0 to 1, leader changed from <none> to de6657ae498d4059a604ab1fc87da05e (127.20.144.65). New cstate: current_term: 1 leader_uuid: "de6657ae498d4059a604ab1fc87da05e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "de6657ae498d4059a604ab1fc87da05e" member_type: VOTER last_known_addr { host: "127.20.144.65" port: 37897 } health_report { overall_health: HEALTHY } } }
02:03:44.983 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet a6baad1189904304a39a820d8ab1199c for table 'org.apache.kudu.client.TestHybridTime-1783476219427' with partition [<start>, <end>)
02:03:44.989 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=a6baad1189904304a39a820d8ab1199c@[3da44ad1364b46febb4043e6764c4e2c(127.20.144.67:40337),5d66ffc0fd334ff2adccf7237ef9d113(127.20.144.66:44903),de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)[L]]}]
02:03:44.990 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.20.144.124:43865, [8ms] Sub RPC GetTableLocations: received response from server master-127.20.144.124:43865: OK, deferred=null) after lookup
02:03:45.000 [DEBUG - kudu-nio-0] (Connection.java:748) [peer de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)] connecting to peer
02:03:45.003 [DEBUG - kudu-nio-3] (Connection.java:757) [peer de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)] Successfully connected to peer
02:03:45.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:45.011456 21471 tablet.cc:2406] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:03:45.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:45.033403 21743 tablet.cc:2406] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:03:45.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 02:03:45.039381 21609 tablet.cc:2406] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:03:45.080 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x639306b0, L:/127.0.0.1:60912 - R:/127.20.144.65:37897] using TOKEN/null
02:03:45.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.091768 21695 raft_consensus.cc:1275] T a6baad1189904304a39a820d8ab1199c P 3da44ad1364b46febb4043e6764c4e2c [term 1 FOLLOWER]: Refusing update from remote peer de6657ae498d4059a604ab1fc87da05e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:03:45.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.091768 21561 raft_consensus.cc:1275] T a6baad1189904304a39a820d8ab1199c P 5d66ffc0fd334ff2adccf7237ef9d113 [term 1 FOLLOWER]: Refusing update from remote peer de6657ae498d4059a604ab1fc87da05e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:03:45.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.093011 21778 consensus_queue.cc:1048] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [LEADER]: Connected to new peer: Peer: permanent_uuid: "5d66ffc0fd334ff2adccf7237ef9d113" member_type: VOTER last_known_addr { host: "127.20.144.66" port: 44903 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:03:45.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.093544 21783 consensus_queue.cc:1048] T a6baad1189904304a39a820d8ab1199c P de6657ae498d4059a604ab1fc87da05e [LEADER]: Connected to new peer: Peer: permanent_uuid: "3da44ad1364b46febb4043e6764c4e2c" member_type: VOTER last_known_addr { host: "127.20.144.67" port: 40337 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:03:45.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.115037 21788 mvcc.cc:204] Tried to move back new op lower bound from 7305118617963204608 to 7305118617312100352. Current Snapshot: MvccSnapshot[applied={T|T < 7305118617963204608}]
02:03:45.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.115541 21787 mvcc.cc:204] Tried to move back new op lower bound from 7305118617963204608 to 7305118617312100352. Current Snapshot: MvccSnapshot[applied={T|T < 7305118617963204608}]
02:03:45.193 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.208 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.218 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.222 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1765231052(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:03:45.236 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.236 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1809060236(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:03:45.252 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.252 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1406047128(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:03:45.263 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:03:45.327 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.337 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305118638443204609) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.345 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305118638443204613) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.352 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305118638443204617) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.359 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305118638443204621) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.366 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305118638443204625) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.373 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305118638443204629) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.381 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305118638443204630) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783476219427, tablet=a6baad1189904304a39a820d8ab1199c, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:03:45.384 [DEBUG - main] (Connection.java:575) [peer master-127.20.144.124:43865(127.20.144.124:43865)] disconnecting while in state READY
02:03:45.385 [DEBUG - main] (Connection.java:575) [peer master-127.20.144.126:40767(127.20.144.126:40767)] disconnecting while in state READY
02:03:45.385 [DEBUG - main] (Connection.java:575) [peer master-127.20.144.125:37777(127.20.144.125:37777)] disconnecting while in state READY
02:03:45.388 [DEBUG - main] (Connection.java:575) [peer de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)] disconnecting while in state READY
02:03:45.390 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.20.144.125:37777(127.20.144.125:37777)] handling channelInactive
02:03:45.390 [DEBUG - kudu-nio-3] (Connection.java:239) [peer de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)] handling channelInactive
02:03:45.391 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.20.144.125:37777(127.20.144.125:37777)] cleaning up while in state READY due to: connection closed
02:03:45.393 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.20.144.126:40767(127.20.144.126:40767)] handling channelInactive
02:03:45.393 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.20.144.126:40767(127.20.144.126:40767)] cleaning up while in state READY due to: connection closed
02:03:45.394 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2704) Releasing all remaining resources
02:03:45.399 [DEBUG - kudu-nio-3] (Connection.java:709) [peer de6657ae498d4059a604ab1fc87da05e(127.20.144.65:37897)] cleaning up while in state READY due to: connection closed
02:03:45.401 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.20.144.124:43865(127.20.144.124:43865)] handling channelInactive
02:03:45.401 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.20.144.124:43865(127.20.144.124:43865)] cleaning up while in state READY due to: connection closed
02:03:45.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.401232 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21330
02:03:45.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.414170 21463 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:45.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.521903 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21330
02:03:45.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.548767 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21478
02:03:45.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.559626 21601 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:45.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.652976 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21478
02:03:45.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.670569 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21613
02:03:45.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.678375 21735 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:45.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.787972 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21613
02:03:45.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.801301 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21068
02:03:45.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.802491 21129 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:45.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.910779 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21068
02:03:45.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.931304 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21136
02:03:45.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:45.932742 21200 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:46.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:46.039880 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21136
02:03:46.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:46.060083 21057 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskmTODK9/build/asan/bin/kudu pid 21207
02:03:46.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:46.061410 21271 generic_service.cc:196] Checking for leaks (request via RPC)
02:03:46.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 02:03:46.177043 21057 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskmTODK9/build/asan/bin/kudu with pid 21207
02:03:46.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T02:03:46Z chronyd exiting

Time: 6.8

OK (1 test)

