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

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

02:03:54.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:54.647794 27600 mini_oidc.cc:150] Starting JWKS server
02:03:54.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:54.652151 27600 webserver.cc:533] Webserver started at http://127.0.0.1:46767/ using document root <none> and password file <none>
02:03:54.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:54.652757 27600 mini_oidc.cc:186] Starting OIDC Discovery server
02:03:54.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:54.655009 27600 webserver.cc:533] Webserver started at http://127.0.0.1:43051/ using document root <none> and password file <none>
02:03:54.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T02:03:54Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
02:03:54.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T02:03:54Z Disabled control of system clock
02:03:54.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:54.717836 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:54.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:54.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal
02:03:54.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data
02:03:54.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:54.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:54.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:54.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:54.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:54.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:54.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/logs
02:03:54.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data/info.pb
02:03:54.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:54.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:54.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:54.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:54.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:54.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:54.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.62:44063
02:03:54.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.62
02:03:54.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:54.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:54.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:54.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:54.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:54.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json with env {}
02:03:55.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.019836 27613 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:55.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.020392 27613 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:55.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.020964 27613 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:55.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.054459 27613 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:55.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.054808 27613 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:55.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.055073 27613 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:55.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.055264 27613 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:55.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.055534 27613 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:55.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.055760 27613 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46767/jwks.json
02:03:55.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:55.093695 27613 master_runner.cc:387] Master server non-default flags:
02:03:55.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:55.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:55.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:55.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:55.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data
02:03:55.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal
02:03:55.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.62:44063
02:03:55.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data/info.pb
02:03:55.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.62
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:55.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/logs
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:55.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:03:55.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:55.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:03:55.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:03:55.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:03:55.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:55.095104 27613 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:55.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:55.097036 27613 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:55.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.109539 27619 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:56.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:55.111900 27620 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:56.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.340485 27622 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:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.342909 27621 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1227 milliseconds
02:03:56.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.342988 27613 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
02:03:56.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.344668 27613 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:56.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.347823 27613 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:56.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.349270 27613 hybrid_clock.cc:648] HybridClock initialized: now 1779069836349213 us; error 58 us; skew 500 ppm
02:03:56.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.350158 27613 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:56.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.356139 27613 webserver.cc:533] Webserver started at http://127.26.244.62:40555/ using document root <none> and password file <none>
02:03:56.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.357123 27613 fs_manager.cc:362] Metadata directory not provided
02:03:56.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.357311 27613 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:56.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.357786 27613 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:56.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.362237 27613 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data/instance:
02:03:56.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3293a733cf94f6d99de37d319e11c46"
02:03:56.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:56 on dist-test-slave-kpl4"
02:03:56.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.363494 27613 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal/instance:
02:03:56.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3293a733cf94f6d99de37d319e11c46"
02:03:56.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:56 on dist-test-slave-kpl4"
02:03:56.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.371258 27613 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.006s	sys 0.001s
02:03:56.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.376768 27629 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.378082 27613 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
02:03:56.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.378435 27613 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal
02:03:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d3293a733cf94f6d99de37d319e11c46"
02:03:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:56 on dist-test-slave-kpl4"
02:03:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.378738 27613 fs_report.cc:389] FS layout report
02:03:56.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal
02:03:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal
02:03:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data/data
02:03:56.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:56.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:56.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.446005 27613 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:56.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.447499 27613 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:56.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.447922 27613 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:56.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.519084 27613 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.62:44063
02:03:56.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.519165 27680 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.62:44063 every 8 connection(s)
02:03:56.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.522023 27613 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/data/info.pb
02:03:56.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.528712 27681 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:56.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.530522 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 27613
02:03:56.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.530982 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-0/wal/instance
02:03:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.534794 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal
02:03:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data
02:03:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/logs
02:03:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data/info.pb
02:03:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.61:33667
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.61
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:56.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:56.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:56.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:56.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:56.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json with env {}
02:03:56.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.541201 27681 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } has no permanent_uuid. Determining permanent_uuid...
02:03:56.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.570848 27681 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } has no permanent_uuid. Determining permanent_uuid...
02:03:56.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.573132 27632 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:56.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.577310 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:56.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.626892 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 1
02:03:56.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.631230 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:56.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.699658 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 2
02:03:56.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.704312 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:56.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.795753 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 3
02:03:56.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.800557 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:56.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.853628 27683 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:56.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.854162 27683 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:56.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.854599 27683 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:56.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.890051 27683 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:56.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.890336 27683 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:56.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.890611 27683 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:56.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.890847 27683 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:56.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.891036 27683 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:56.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.891175 27683 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46767/jwks.json
02:03:56.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.931903 27683 master_runner.cc:387] Master server non-default flags:
02:03:56.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal
02:03:56.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.61:33667
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json
02:03:56.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data/info.pb
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.61
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:56.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:56.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:56.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:56.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/logs
02:03:56.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:56.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:56.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:56.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:56.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:56.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:03:56.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:56.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:03:56.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:03:56.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:03:56.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.933548 27683 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:56.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.935252 27683 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:56.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:56.943971 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 4
02:03:56.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.949102 27692 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:56.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.951107 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:57.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:57.250622 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 5
02:03:57.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:57.261579 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:57.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:57.809219 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 6
02:03:57.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:57.837240 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.61:33667: Network error: Client connection negotiation failed: client connection to 127.26.244.61:33667: connect: Connection refused (error 111)
02:03:58.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:56.952585 27693 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:58.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.277880 27695 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:58.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.281733 27694 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1327 milliseconds
02:03:58.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.282169 27683 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.332s	user 0.460s	sys 0.867s
02:03:58.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.282546 27683 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.332s	user 0.460s	sys 0.867s
02:03:58.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.282831 27683 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
02:03:58.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.284435 27683 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:03:58.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.287814 27683 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:03:58.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.289839 27683 hybrid_clock.cc:648] HybridClock initialized: now 1779069838289751 us; error 83 us; skew 500 ppm
02:03:58.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.291469 27683 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:03:58.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.301108 27683 webserver.cc:533] Webserver started at http://127.26.244.61:35369/ using document root <none> and password file <none>
02:03:58.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.302558 27683 fs_manager.cc:362] Metadata directory not provided
02:03:58.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.302876 27683 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:03:58.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.303506 27683 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.311093 27683 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data/instance:
02:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6df8893774cf4ec29ff402d43f25cdca"
02:03:58.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:58 on dist-test-slave-kpl4"
02:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.312870 27683 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal/instance:
02:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6df8893774cf4ec29ff402d43f25cdca"
02:03:58.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:58 on dist-test-slave-kpl4"
02:03:58.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.324642 27683 fs_manager.cc:696] Time spent creating directory manager: real 0.010s	user 0.000s	sys 0.009s
02:03:58.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.332643 27704 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:03:58.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.333870 27683 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.003s
02:03:58.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.334259 27683 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal
02:03:58.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6df8893774cf4ec29ff402d43f25cdca"
02:03:58.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:03:58 on dist-test-slave-kpl4"
02:03:58.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.334658 27683 fs_report.cc:389] FS layout report
02:03:58.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:03:58.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data/data
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:03:58.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:03:58.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:03:58.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:03:58.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:03:58.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:03:58.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:03:58.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.413429 27683 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:03:58.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.414974 27683 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:58.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.415453 27683 kserver.cc:163] Server-wide thread pool size limit: 3276
02:03:58.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.485853 27683 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.61:33667
02:03:58.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.485927 27755 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.61:33667 every 8 connection(s)
02:03:58.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.488790 27683 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/data/info.pb
02:03:58.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.492753 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 27683
02:03:58.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.493220 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-1/wal/instance
02:03:58.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.495905 27756 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:58.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.496181 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:58.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:03:58.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:58.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/logs
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data/info.pb
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:58.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.60:37121
02:03:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.60
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:58.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:58.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:58.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:58.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json with env {}
02:03:58.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.509298 27756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } has no permanent_uuid. Determining permanent_uuid...
02:03:58.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.531658 27756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } has no permanent_uuid. Determining permanent_uuid...
02:03:58.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.546665 27756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } has no permanent_uuid. Determining permanent_uuid...
02:03:58.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.549453 27706 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.554001 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.603626 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 1
02:03:58.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.607731 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.676287 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 2
02:03:58.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.680696 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.772159 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 3
02:03:58.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.776585 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.821460 27758 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:03:58.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.821995 27758 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:03:58.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.822428 27758 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:03:58.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.855228 27758 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
02:03:58.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.855580 27758 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:03:58.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.855911 27758 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
02:03:58.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.856156 27758 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
02:03:58.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.856412 27758 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
02:03:58.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.856554 27758 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:46767/jwks.json
02:03:58.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.894815 27758 master_runner.cc:387] Master server non-default flags:
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data
02:03:58.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.60:37121
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:03:58.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46767/jwks.json
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data/info.pb
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.60
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:03:58.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:03:58.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:03:58.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:03:58.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:03:58.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/logs
02:03:58.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:03:58.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:03:58.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:03:58.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
02:03:58.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:03:58.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:03:58.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:03:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:03:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:03:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:03:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.896531 27758 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:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.897857 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } attempt: 7
02:03:58.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.898765 27758 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:03:58.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.915002 27769 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:58.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.920261 27681 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } has no permanent_uuid. Determining permanent_uuid...
02:03:58.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.921236 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 4
02:03:58.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.927418 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.939234 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:58.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:58.998055 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 1
02:03:59.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.005232 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.086814 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 2
02:03:59.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.093860 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.179466 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 3
02:03:59.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.186513 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.226871 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 5
02:03:59.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.234349 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.327071 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 4
02:03:59.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.333770 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.617316 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 5
02:03:59.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.623971 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:03:59.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:03:59.781942 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 6
02:03:59.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:59.794898 27756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:04:00.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.176569 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 6
02:04:00.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.916042 27770 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:04:00.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:03:58.921586 27772 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:04:00.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.187285 27771 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1260 milliseconds
02:04:00.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.187297 27681 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.26.244.60:37121: Network error: Client connection negotiation failed: client connection to 127.26.244.60:37121: connect: Connection refused (error 111)
02:04:00.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.187472 27758 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
02:04:00.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.188705 27758 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:04:00.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.191435 27758 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:04:00.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.192924 27758 hybrid_clock.cc:648] HybridClock initialized: now 1779069840192836 us; error 92 us; skew 500 ppm
02:04:00.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.193732 27758 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:04:00.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.200234 27758 webserver.cc:533] Webserver started at http://127.26.244.60:45163/ using document root <none> and password file <none>
02:04:00.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.201190 27758 fs_manager.cc:362] Metadata directory not provided
02:04:00.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.201382 27758 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:04:00.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.201766 27758 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:04:00.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.206221 27758 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data/instance:
02:04:00.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7131ad6866984ed4b19ecc71c5eb833f"
02:04:00.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:00 on dist-test-slave-kpl4"
02:04:00.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.207388 27758 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal/instance:
02:04:00.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7131ad6866984ed4b19ecc71c5eb833f"
02:04:00.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:00 on dist-test-slave-kpl4"
02:04:00.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.216075 27758 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.001s
02:04:00.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.222090 27784 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:04:00.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.223582 27758 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.006s	sys 0.000s
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.223961 27758 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7131ad6866984ed4b19ecc71c5eb833f"
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:00 on dist-test-slave-kpl4"
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.224273 27758 fs_report.cc:389] FS layout report
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal
02:04:00.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data/data
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:04:00.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:04:00.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.280149 27758 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:04:00.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.281656 27758 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:04:00.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.282073 27758 kserver.cc:163] Server-wide thread pool size limit: 3276
02:04:00.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.366124 27758 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.60:37121
02:04:00.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.366243 27835 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.60:37121 every 8 connection(s)
02:04:00.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.368865 27758 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/data/info.pb
02:04:00.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.375461 27836 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:04:00.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.377665 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 27758
02:04:00.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.378194 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/master-2/wal/instance
02:04:00.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.390062 27836 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } has no permanent_uuid. Determining permanent_uuid...
02:04:00.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.421881 27836 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } has no permanent_uuid. Determining permanent_uuid...
02:04:00.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.433182 27836 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } has no permanent_uuid. Determining permanent_uuid...
02:04:00.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.450189 27836 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: Bootstrap starting.
02:04:00.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.458048 27836 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: Neither blocks nor log segments found. Creating new log.
02:04:00.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.459995 27836 log.cc:826] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: Log is configured to *not* fsync() on all Append() calls
02:04:00.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.465346 27836 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: No bootstrap required, opened a new log
02:04:00.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.489092 27836 raft_consensus.cc:359] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:00.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.491274 27836 raft_consensus.cc:385] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:00.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.491945 27836 raft_consensus.cc:740] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7131ad6866984ed4b19ecc71c5eb833f, State: Initialized, Role: FOLLOWER
02:04:00.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.493021 27836 consensus_queue.cc:260] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:00.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.496601 27845 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:00.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.497973 27845 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: This master's current role is: FOLLOWER
02:04:00.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.498894 27836 sys_catalog.cc:565] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: configured and running, proceeding with master startup.
02:04:00.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.538368 27790 tablet.cc:2404] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:00.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.548959 27856 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:04:00.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.549770 27856 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:04:00.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.536935 27758 master_runner.cc:187] Error getting master registration for 127.26.244.62:44063: OK, instance_id { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" instance_seqno: 1779069836499382 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:04:00.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.570355 27758 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:04:00.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.855513 27756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 7
02:04:00.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.875155 27756 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: Bootstrap starting.
02:04:00.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.881901 27756 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: Neither blocks nor log segments found. Creating new log.
02:04:00.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.883673 27756 log.cc:826] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: Log is configured to *not* fsync() on all Append() calls
02:04:00.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.889215 27756 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: No bootstrap required, opened a new log
02:04:00.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.914054 27756 raft_consensus.cc:359] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:00.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.915134 27756 raft_consensus.cc:385] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:00.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.915354 27756 raft_consensus.cc:740] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6df8893774cf4ec29ff402d43f25cdca, State: Initialized, Role: FOLLOWER
02:04:00.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.916134 27756 consensus_queue.cc:260] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:00.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.919124 27860 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:00.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.919999 27860 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: This master's current role is: FOLLOWER
02:04:00.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.921566 27756 sys_catalog.cc:565] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: configured and running, proceeding with master startup.
02:04:00.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.924443 27710 tablet.cc:2404] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:00.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.954309 27871 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
02:04:00.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:00.955161 27871 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
02:04:00.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.948845 27683 master_runner.cc:187] Error getting master registration for 127.26.244.62:44063: OK, instance_id { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" instance_seqno: 1779069836499382 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
02:04:00.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.978466 27683 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
02:04:00.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.980417 27845 raft_consensus.cc:493] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:04:00.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.980940 27845 raft_consensus.cc:515] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:00.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.984632 27845 leader_election.cc:290] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers d3293a733cf94f6d99de37d319e11c46 (127.26.244.62:44063), 6df8893774cf4ec29ff402d43f25cdca (127.26.244.61:33667)
02:04:00.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.984751 27731 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "7131ad6866984ed4b19ecc71c5eb833f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6df8893774cf4ec29ff402d43f25cdca" is_pre_election: true
02:04:00.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.985632 27731 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 7131ad6866984ed4b19ecc71c5eb833f in term 0.
02:04:00.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.987030 27787 leader_election.cc:304] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [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: 6df8893774cf4ec29ff402d43f25cdca, 7131ad6866984ed4b19ecc71c5eb833f; no voters: 
02:04:00.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.987927 27845 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Leader pre-election won for term 1
02:04:00.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.988277 27845 raft_consensus.cc:493] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:04:00.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:00.989245 27845 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 0 FOLLOWER]: Advancing to term 1
02:04:01.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.002846 27845 raft_consensus.cc:515] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:01.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.015368 27845 leader_election.cc:290] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [CANDIDATE]: Term 1 election: Requested vote from peers d3293a733cf94f6d99de37d319e11c46 (127.26.244.62:44063), 6df8893774cf4ec29ff402d43f25cdca (127.26.244.61:33667)
02:04:01.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.015556 27731 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "7131ad6866984ed4b19ecc71c5eb833f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6df8893774cf4ec29ff402d43f25cdca"
02:04:01.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.016139 27731 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 0 FOLLOWER]: Advancing to term 1
02:04:01.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.024621 27731 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 7131ad6866984ed4b19ecc71c5eb833f in term 1.
02:04:01.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.026333 27787 leader_election.cc:304] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [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: 6df8893774cf4ec29ff402d43f25cdca, 7131ad6866984ed4b19ecc71c5eb833f; no voters: 
02:04:01.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.027238 27845 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 1 FOLLOWER]: Leader election won for term 1
02:04:01.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.031291 27845 raft_consensus.cc:697] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [term 1 LEADER]: Becoming Leader. State: Replica: 7131ad6866984ed4b19ecc71c5eb833f, State: Running, Role: LEADER
02:04:01.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.032707 27845 consensus_queue.cc:237] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:01.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.041512 27873 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: SysCatalogTable state changed. Reason: New leader 7131ad6866984ed4b19ecc71c5eb833f. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.042918 27873 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: This master's current role is: LEADER
02:04:01.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.054378 27875 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
02:04:01.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.063057 27875 catalog_manager.cc:1519] Initializing Kudu cluster ID...
02:04:01.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.081795 27731 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [term 1 FOLLOWER]: Refusing update from remote peer 7131ad6866984ed4b19ecc71c5eb833f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:04:01.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.088168 27873 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [LEADER]: Connected to new peer: Peer: permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:04:01.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.119966 27860 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: SysCatalogTable state changed. Reason: New leader 7131ad6866984ed4b19ecc71c5eb833f. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.121311 27860 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: This master's current role is: FOLLOWER
02:04:01.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.126592 27876 mvcc.cc:204] Tried to move back new op lower bound from 7287070069052473344 to 7287070068882997248. Current Snapshot: MvccSnapshot[applied={T|T < 7287070069052473344}]
02:04:01.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.130312 27845 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.131521 27845 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: This master's current role is: LEADER
02:04:01.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.138716 27860 sys_catalog.cc:455] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.139432 27860 sys_catalog.cc:458] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca [sys.catalog]: This master's current role is: FOLLOWER
02:04:01.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.144547 27875 catalog_manager.cc:1382] Generated new cluster ID: 2cb7b2c7cb59486bb88a85c6c45015c8
02:04:01.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.144858 27875 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
02:04:01.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.205185 27875 catalog_manager.cc:1405] Generated new certificate authority record
02:04:01.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.207669 27875 catalog_manager.cc:1539] Loading token signing keys...
02:04:01.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.220719 27681 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } attempt: 7
02:04:01.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.236984 27875 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f: Generated new TSK 0
02:04:01.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.253149 27875 catalog_manager.cc:1549] Initializing in-progress tserver states...
02:04:01.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.259994 27681 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: Bootstrap starting.
02:04:01.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.267005 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:01.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:01.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal
02:04:01.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/logs
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data/info.pb
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:04:01.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.1:0
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.1
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.1
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:01.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:04:01.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.268464 27681 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: Neither blocks nor log segments found. Creating new log.
02:04:01.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.271728 27681 log.cc:826] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: Log is configured to *not* fsync() on all Append() calls
02:04:01.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.288545 27681 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: No bootstrap required, opened a new log
02:04:01.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.359457 27681 raft_consensus.cc:359] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:01.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.362169 27681 raft_consensus.cc:385] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:01.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.377715 27681 raft_consensus.cc:740] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d3293a733cf94f6d99de37d319e11c46, State: Initialized, Role: FOLLOWER
02:04:01.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.384279 27681 consensus_queue.cc:260] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } }
02:04:01.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.408854 27884 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [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: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.409768 27884 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: This master's current role is: FOLLOWER
02:04:01.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.418262 27654 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [term 0 FOLLOWER]: Advancing to term 1
02:04:01.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.423220 27655 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "7131ad6866984ed4b19ecc71c5eb833f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d3293a733cf94f6d99de37d319e11c46"
02:04:01.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.425279 27656 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "7131ad6866984ed4b19ecc71c5eb833f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "d3293a733cf94f6d99de37d319e11c46" is_pre_election: true
02:04:01.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.432154 27654 raft_consensus.cc:1275] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [term 1 FOLLOWER]: Refusing update from remote peer 7131ad6866984ed4b19ecc71c5eb833f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:04:01.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.445305 27845 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [LEADER]: Connected to new peer: Peer: permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:04:01.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.446697 27681 sys_catalog.cc:565] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: configured and running, proceeding with master startup.
02:04:01.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.460129 27635 tablet.cc:2404] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:01.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.509473 27886 mvcc.cc:204] Tried to move back new op lower bound from 7287070069052473344 to 7287070068882997248. Current Snapshot: MvccSnapshot[applied={T|T < 7287070069052473344}]
02:04:01.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.563210 27884 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 7131ad6866984ed4b19ecc71c5eb833f. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.563408 27890 sys_catalog.cc:455] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.564669 27884 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: This master's current role is: FOLLOWER
02:04:01.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.564705 27890 sys_catalog.cc:458] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46 [sys.catalog]: This master's current role is: FOLLOWER
02:04:01.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.609622 27900 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
02:04:01.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.809947 27883 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:04:01.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.810618 27883 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:04:01.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.811306 27883 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:04:01.875 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.875166 27883 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:04:01.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.876539 27883 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.244.1
02:04:01.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.945237 27883 tablet_server_runner.cc:78] Tablet server non-default flags:
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.1:0
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data/info.pb
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.1
02:04:01.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.1
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/logs
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:04:01.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.946552 27905 sys_catalog.cc:455] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "7131ad6866984ed4b19ecc71c5eb833f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "d3293a733cf94f6d99de37d319e11c46" member_type: VOTER last_known_addr { host: "127.26.244.62" port: 44063 } } peers { permanent_uuid: "6df8893774cf4ec29ff402d43f25cdca" member_type: VOTER last_known_addr { host: "127.26.244.61" port: 33667 } } peers { permanent_uuid: "7131ad6866984ed4b19ecc71c5eb833f" member_type: VOTER last_known_addr { host: "127.26.244.60" port: 37121 } } }
02:04:01.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.947310 27905 sys_catalog.cc:458] T 00000000000000000000000000000000 P 7131ad6866984ed4b19ecc71c5eb833f [sys.catalog]: This master's current role is: LEADER
02:04:01.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.949903 27883 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:04:01.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.952509 27883 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:04:01.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.960855 27871 catalog_manager.cc:1294] Loaded cluster ID: 2cb7b2c7cb59486bb88a85c6c45015c8
02:04:01.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.961519 27871 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: loading cluster ID for follower catalog manager: success
02:04:01.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.972115 27871 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: acquiring CA information for follower catalog manager: success
02:04:01.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:01.978434 27871 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 6df8893774cf4ec29ff402d43f25cdca: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:04:01.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.988296 27909 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:04:02.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:02.641558 27900 catalog_manager.cc:1294] Loaded cluster ID: 2cb7b2c7cb59486bb88a85c6c45015c8
02:04:02.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:02.641956 27900 catalog_manager.cc:1587] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: loading cluster ID for follower catalog manager: success
02:04:02.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:02.685105 27900 catalog_manager.cc:1609] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: acquiring CA information for follower catalog manager: success
02:04:02.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:02.709317 27900 catalog_manager.cc:1637] T 00000000000000000000000000000000 P d3293a733cf94f6d99de37d319e11c46: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
02:04:03.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:01.989846 27910 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:04:03.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:03.960053 27883 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 1.973s	user 0.578s	sys 1.138s
02:04:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:03.962384 27883 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 1.975s	user 0.578s	sys 1.138s
02:04:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:03.386452 27908 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 27883
02:04:03.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:03.974367 27883 server_base.cc:1061] running on GCE node
02:04:03.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:03.974972 27915 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:04:03.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:03.976678 27883 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:04:03.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:03.988370 27883 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:04:03.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:03.990279 27883 hybrid_clock.cc:648] HybridClock initialized: now 1779069843990239 us; error 50 us; skew 500 ppm
02:04:03.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:03.992101 27883 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:04:04.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.010982 27883 webserver.cc:533] Webserver started at http://127.26.244.1:45819/ using document root <none> and password file <none>
02:04:04.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.012702 27883 fs_manager.cc:362] Metadata directory not provided
02:04:04.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.013253 27883 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:04:04.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.014025 27883 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:04:04.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.021026 27883 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data/instance:
02:04:04.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4600b6a0596e4552b39c542ea626cfee"
02:04:04.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:04 on dist-test-slave-kpl4"
02:04:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.023061 27883 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal/instance:
02:04:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4600b6a0596e4552b39c542ea626cfee"
02:04:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:04 on dist-test-slave-kpl4"
02:04:04.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.038652 27883 fs_manager.cc:696] Time spent creating directory manager: real 0.014s	user 0.006s	sys 0.007s
02:04:04.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.052217 27920 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:04:04.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.053920 27883 fs_manager.cc:730] Time spent opening block manager: real 0.010s	user 0.004s	sys 0.007s
02:04:04.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.054602 27883 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal
02:04:04.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4600b6a0596e4552b39c542ea626cfee"
02:04:04.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:04 on dist-test-slave-kpl4"
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.055397 27883 fs_report.cc:389] FS layout report
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data/data
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:04:04.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:04:04.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:04:04.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:04:04.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.149904 27883 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:04:04.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.152401 27883 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:04:04.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.153342 27883 kserver.cc:163] Server-wide thread pool size limit: 3276
02:04:04.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.168407 27883 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:04:04.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.189070 27883 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:04:04.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.189843 27883 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.001s	user 0.001s	sys 0.000s
02:04:04.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.190377 27883 ts_tablet_manager.cc:616] Registered 0 tablets
02:04:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.190786 27883 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:04:04.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.459704 27883 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.1:38965
02:04:04.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.459853 28032 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.1:38965 every 8 connection(s)
02:04:04.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.463150 27883 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/data/info.pb
02:04:04.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.472898 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 27883
02:04:04.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.473490 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-0/wal/instance
02:04:04.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.491232 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:04.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/logs
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data/info.pb
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:04.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.2:0
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.2
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.2
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:04.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:04:04.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.587518 28034 heartbeater.cc:344] Connected to a master server at 127.26.244.61:33667
02:04:04.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.588255 28034 heartbeater.cc:461] Registering TS with master...
02:04:04.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.590384 28034 heartbeater.cc:507] Master 127.26.244.61:33667 requested a full tablet report, sending...
02:04:04.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.595805 27721 ts_manager.cc:194] Registered new tserver with Master: 4600b6a0596e4552b39c542ea626cfee (127.26.244.1:38965)
02:04:04.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.610050 28033 heartbeater.cc:344] Connected to a master server at 127.26.244.60:37121
02:04:04.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.610440 28033 heartbeater.cc:461] Registering TS with master...
02:04:04.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.611343 28033 heartbeater.cc:507] Master 127.26.244.60:37121 requested a full tablet report, sending...
02:04:04.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.614463 27801 ts_manager.cc:194] Registered new tserver with Master: 4600b6a0596e4552b39c542ea626cfee (127.26.244.1:38965)
02:04:04.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.617213 27801 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.244.1:51017
02:04:04.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.632066 28037 heartbeater.cc:344] Connected to a master server at 127.26.244.62:44063
02:04:04.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.632432 28037 heartbeater.cc:461] Registering TS with master...
02:04:04.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.633087 28037 heartbeater.cc:507] Master 127.26.244.62:44063 requested a full tablet report, sending...
02:04:04.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.636516 27646 ts_manager.cc:194] Registered new tserver with Master: 4600b6a0596e4552b39c542ea626cfee (127.26.244.1:38965)
02:04:04.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:04.915551 28040 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:04:04.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:04.916766 28040 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:04:04.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:04.917529 28040 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:04:04.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:04.951731 28040 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:04:04.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:04.952772 28040 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.244.2
02:04:04.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.991178 28040 tablet_server_runner.cc:78] Tablet server non-default flags:
02:04:04.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:04.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:04.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:04.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:04:04.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.2:0
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data/info.pb
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.2
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:04.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.2
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/logs
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:04:04.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:04:04.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:04:04.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:04:04.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.992895 28040 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:04:04.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:04.995306 28040 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:04:05.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:05.010221 28051 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:04:05.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:05.621274 28033 heartbeater.cc:499] Master 127.26.244.60:37121 was elected leader, sending a full tablet report...
02:04:06.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.415601 28049 debug-util.cc:398] Leaking SignalData structure 0x7b08000271c0 after lost signal to thread 28040
02:04:06.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.763537 28049 kernel_stack_watchdog.cc:198] Thread 28040 stuck at /home/jenkins-slave/workspace/build_and_test_flaky@2/src/kudu/util/thread.cc:642 for 400ms:
02:04:06.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
02:04:06.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
02:04:06.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
02:04:06.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
02:04:06.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:05.011533 28052 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:04:06.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.765470 28040 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.753s	user 0.000s	sys 0.002s
02:04:06.766 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.765820 28040 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.754s	user 0.000s	sys 0.002s
02:04:06.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.768975 28054 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:04:06.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:06.772214 28053 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1758 milliseconds
02:04:06.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.772255 28040 server_base.cc:1056] Not found: could not retrieve instance metadata: unable to detect cloud type of this node, probably running in non-cloud environment
02:04:06.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.773535 28040 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:04:06.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.776103 28040 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:04:06.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.777576 28040 hybrid_clock.cc:648] HybridClock initialized: now 1779069846777552 us; error 51 us; skew 500 ppm
02:04:06.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.778353 28040 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:04:06.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.786916 28040 webserver.cc:533] Webserver started at http://127.26.244.2:38003/ using document root <none> and password file <none>
02:04:06.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.788012 28040 fs_manager.cc:362] Metadata directory not provided
02:04:06.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.788234 28040 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:04:06.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.788651 28040 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:04:06.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.793151 28040 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data/instance:
02:04:06.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "04e047c67acc4b6c8a5d951935525757"
02:04:06.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:06 on dist-test-slave-kpl4"
02:04:06.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.794268 28040 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal/instance:
02:04:06.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "04e047c67acc4b6c8a5d951935525757"
02:04:06.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:06 on dist-test-slave-kpl4"
02:04:06.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.803052 28040 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.009s	sys 0.000s
02:04:06.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.809603 28061 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:04:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.810899 28040 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.003s
02:04:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.811205 28040 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal
02:04:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "04e047c67acc4b6c8a5d951935525757"
02:04:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:06 on dist-test-slave-kpl4"
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.811518 28040 fs_report.cc:389] FS layout report
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data/data
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:04:06.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:04:06.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:04:06.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.884150 28040 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:04:06.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.885918 28040 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:04:06.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.886361 28040 kserver.cc:163] Server-wide thread pool size limit: 3276
02:04:06.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.889225 28040 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:04:06.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.894038 28040 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:04:06.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.894296 28040 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:04:06.894 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.894604 28040 ts_tablet_manager.cc:616] Registered 0 tablets
02:04:06.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:06.894811 28040 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:04:07.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.049983 28040 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.2:41771
02:04:07.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.050074 28174 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.2:41771 every 8 connection(s)
02:04:07.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.052950 28040 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/data/info.pb
02:04:07.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.060382 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 28040
02:04:07.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.061216 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-1/wal/instance
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.081552 27600 external_mini_cluster.cc:1366] Running /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_AskSq/build/tsan/bin/kudu
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:07.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/logs
02:04:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data/info.pb
02:04:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
02:04:07.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.3:0
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.3
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.3
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:07.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:07.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:07.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.115876 28175 heartbeater.cc:344] Connected to a master server at 127.26.244.60:37121
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.116101 28177 heartbeater.cc:344] Connected to a master server at 127.26.244.62:44063
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.116242 28176 heartbeater.cc:344] Connected to a master server at 127.26.244.61:33667
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.116439 28175 heartbeater.cc:461] Registering TS with master...
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.116597 28176 heartbeater.cc:461] Registering TS with master...
02:04:07.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.116639 28177 heartbeater.cc:461] Registering TS with master...
02:04:07.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.118100 28177 heartbeater.cc:507] Master 127.26.244.62:44063 requested a full tablet report, sending...
02:04:07.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.118373 28175 heartbeater.cc:507] Master 127.26.244.60:37121 requested a full tablet report, sending...
02:04:07.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.120098 28176 heartbeater.cc:507] Master 127.26.244.61:33667 requested a full tablet report, sending...
02:04:07.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.120904 27801 ts_manager.cc:194] Registered new tserver with Master: 04e047c67acc4b6c8a5d951935525757 (127.26.244.2:41771)
02:04:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.122506 27646 ts_manager.cc:194] Registered new tserver with Master: 04e047c67acc4b6c8a5d951935525757 (127.26.244.2:41771)
02:04:07.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.122675 27801 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.244.2:50003
02:04:07.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.126220 27721 ts_manager.cc:194] Registered new tserver with Master: 04e047c67acc4b6c8a5d951935525757 (127.26.244.2:41771)
02:04:07.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.439723 28185 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
02:04:07.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.440224 28185 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
02:04:07.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.440651 28185 flags.cc:432] Enabled unsafe flag: --never_fsync=true
02:04:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.483551 28185 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
02:04:07.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.484398 28185 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.244.3
02:04:07.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.524369 28185 tablet_server_runner.cc:78] Tablet server non-default flags:
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.244.20:42183
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.244.3:0
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data/info.pb
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.244.3
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.244.62:44063,127.26.244.61:33667,127.26.244.60:37121
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.244.3
02:04:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/logs
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 66827b15b158c37363c37baa160f29a0ca1f1e63
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 01:43:23 UTC on e7f111948823
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 11951
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
02:04:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.525656 28185 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:04:07.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.527206 28185 file_cache.cc:492] Constructed file cache file cache with capacity 419430
02:04:07.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.546535 28191 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:04:08.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.126513 28175 heartbeater.cc:499] Master 127.26.244.60:37121 was elected leader, sending a full tablet report...
02:04:08.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.549482 28194 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:04:08.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:07.549655 28192 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:04:08.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:07.549926 28185 server_base.cc:1061] running on GCE node
02:04:08.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.774015 28185 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
02:04:08.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.776904 28185 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
02:04:08.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.778333 28185 hybrid_clock.cc:648] HybridClock initialized: now 1779069848778287 us; error 38 us; skew 500 ppm
02:04:08.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.779341 28185 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
02:04:08.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.787010 28185 webserver.cc:533] Webserver started at http://127.26.244.3:36007/ using document root <none> and password file <none>
02:04:08.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.788230 28185 fs_manager.cc:362] Metadata directory not provided
02:04:08.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.788518 28185 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
02:04:08.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.789150 28185 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
02:04:08.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.794008 28185 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data/instance:
02:04:08.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7081b34a30494c3ab81a455204a02a4e"
02:04:08.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:08 on dist-test-slave-kpl4"
02:04:08.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.795362 28185 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal/instance:
02:04:08.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7081b34a30494c3ab81a455204a02a4e"
02:04:08.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:08 on dist-test-slave-kpl4"
02:04:08.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.805550 28185 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.005s	sys 0.003s
02:04:08.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.815337 28202 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
02:04:08.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.817440 28185 fs_manager.cc:730] Time spent opening block manager: real 0.007s	user 0.003s	sys 0.004s
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.817751 28185 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data,/tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7081b34a30494c3ab81a455204a02a4e"
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 02:04:08 on dist-test-slave-kpl4"
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.818084 28185 fs_report.cc:389] FS layout report
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data/data
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
02:04:08.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
02:04:08.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
02:04:08.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.874259 28185 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
02:04:08.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.875973 28185 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:04:08.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.876430 28185 kserver.cc:163] Server-wide thread pool size limit: 3276
02:04:08.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.879215 28185 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
02:04:08.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.884021 28185 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
02:04:08.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.884294 28185 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
02:04:08.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.884673 28185 ts_tablet_manager.cc:616] Registered 0 tablets
02:04:08.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:08.884900 28185 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
02:04:09.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.039137 28185 rpc_server.cc:307] RPC server started. Bound to: 127.26.244.3:41395
02:04:09.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.039240 28314 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.26.244.3:41395 every 8 connection(s)
02:04:09.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.041829 28185 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/data/info.pb
02:04:09.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.045454 27600 external_mini_cluster.cc:1428] Started /tmp/dist-test-task_AskSq/build/tsan/bin/kudu as pid 28185
02:04:09.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.045914 27600 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task_AskSq/test-tmp/mini-kudu-cluster9121320553471504492/ts-2/wal/instance
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.104769 28315 heartbeater.cc:344] Connected to a master server at 127.26.244.60:37121
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.105158 28317 heartbeater.cc:344] Connected to a master server at 127.26.244.62:44063
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.105110 28316 heartbeater.cc:344] Connected to a master server at 127.26.244.61:33667
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.105309 28315 heartbeater.cc:461] Registering TS with master...
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.105516 28317 heartbeater.cc:461] Registering TS with master...
02:04:09.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.105516 28316 heartbeater.cc:461] Registering TS with master...
02:04:09.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.107349 28315 heartbeater.cc:507] Master 127.26.244.60:37121 requested a full tablet report, sending...
02:04:09.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.107439 28316 heartbeater.cc:507] Master 127.26.244.61:33667 requested a full tablet report, sending...
02:04:09.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.107375 28317 heartbeater.cc:507] Master 127.26.244.62:44063 requested a full tablet report, sending...
02:04:09.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.110476 27721 ts_manager.cc:194] Registered new tserver with Master: 7081b34a30494c3ab81a455204a02a4e (127.26.244.3:41395)
02:04:09.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.110445 27801 ts_manager.cc:194] Registered new tserver with Master: 7081b34a30494c3ab81a455204a02a4e (127.26.244.3:41395)
02:04:09.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.110694 27646 ts_manager.cc:194] Registered new tserver with Master: 7081b34a30494c3ab81a455204a02a4e (127.26.244.3:41395)
02:04:09.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.112326 27801 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.26.244.3:41957
02:04:09.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:09.122150 27600 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
02:04:09.135 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
02:04:09.136 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

02:04:09.144 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.244.62"
      port: 44063
    }
    bound_http_address {
      host: "127.26.244.62"
      port: 40555
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.244.61"
      port: 33667
    }
    bound_http_address {
      host: "127.26.244.61"
      port: 35369
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.244.60"
      port: 37121
    }
    bound_http_address {
      host: "127.26.244.60"
      port: 45163
    }
  }
}

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

02:04:09.150 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.244.1"
      port: 38965
    }
    bound_http_address {
      host: "127.26.244.1"
      port: 45819
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.244.2"
      port: 41771
    }
    bound_http_address {
      host: "127.26.244.2"
      port: 38003
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.244.3"
      port: 41395
    }
    bound_http_address {
      host: "127.26.244.3"
      port: 36007
    }
  }
}

02:04:09.150 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
02:04:09.322 [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.doOneAttemptAndReport(RetryRule.java:184)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:244)
	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:04:09.377 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
02:04:09.538 [DEBUG - main] (Connection.java:748) [peer master-127.26.244.61:33667(127.26.244.61:33667)] connecting to peer
02:04:09.592 [DEBUG - main] (Connection.java:748) [peer master-127.26.244.62:44063(127.26.244.62:44063)] connecting to peer
02:04:09.602 [DEBUG - main] (Connection.java:748) [peer master-127.26.244.60:37121(127.26.244.60:37121)] connecting to peer
02:04:09.613 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.26.244.61:33667(127.26.244.61:33667)] Successfully connected to peer
02:04:09.615 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.26.244.60:37121(127.26.244.60:37121)] Successfully connected to peer
02:04:09.615 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.26.244.62:44063(127.26.244.62:44063)] Successfully connected to peer
02:04:09.709 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.244.62
02:04:09.712 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.244.60
02:04:09.714 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.26.244.61
02:04:09.946 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xf6048b7c, L:/127.0.0.1:39546 - R:/127.26.244.62:44063] using SASL/PLAIN
02:04:09.946 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0xc4b180e0, L:/127.0.0.1:59530 - R:/127.26.244.60:37121] using SASL/PLAIN
02:04:09.946 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xb29bc156, L:/127.0.0.1:35686 - R:/127.26.244.61:33667] using SASL/PLAIN
02:04:09.987 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
02:04:09.989 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=493), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.244.61:33667, [92ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.244.62:44063, [100ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.244.60:37121, [464ms] Sub RPC ConnectToMaster: received response from server master-127.26.244.61:33667: OK, [464ms] Sub RPC ConnectToMaster: received response from server master-127.26.244.62:44063: OK, [464ms] Sub RPC ConnectToMaster: received response from server master-127.26.244.60:37121: OK, deferred=null) after lookup
02:04:10.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.042443 27801 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:59530:
02:04:10.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1779069834037"
02:04:10.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
02:04:10.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
02:04:10.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
02:04:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
02:04:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
02:04:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
02:04:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
02:04:10.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:10.045615 27801 catalog_manager.cc:7058] 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-1779069834037 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
02:04:10.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.116165 28315 heartbeater.cc:499] Master 127.26.244.60:37121 was elected leader, sending a full tablet report...
02:04:10.117 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:894) Opened table 1e19789f80b442aebdc497d098d192b9
02:04:10.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.151691 28250 tablet_service.cc:1511] Processing CreateTablet for tablet dcd8ad3ba73e4cafaa9012ed440eaecc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069834037 [id=1e19789f80b442aebdc497d098d192b9]), partition=RANGE (key) PARTITION UNBOUNDED
02:04:10.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.156852 28250 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet dcd8ad3ba73e4cafaa9012ed440eaecc. 1 dirs total, 0 dirs full, 0 dirs failed
02:04:10.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.157837 28110 tablet_service.cc:1511] Processing CreateTablet for tablet dcd8ad3ba73e4cafaa9012ed440eaecc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069834037 [id=1e19789f80b442aebdc497d098d192b9]), partition=RANGE (key) PARTITION UNBOUNDED
02:04:10.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.160463 28110 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet dcd8ad3ba73e4cafaa9012ed440eaecc. 1 dirs total, 0 dirs full, 0 dirs failed
02:04:10.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.160261 27968 tablet_service.cc:1511] Processing CreateTablet for tablet dcd8ad3ba73e4cafaa9012ed440eaecc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1779069834037 [id=1e19789f80b442aebdc497d098d192b9]), partition=RANGE (key) PARTITION UNBOUNDED
02:04:10.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.161885 27968 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet dcd8ad3ba73e4cafaa9012ed440eaecc. 1 dirs total, 0 dirs full, 0 dirs failed
02:04:10.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.187098 28349 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Bootstrap starting.
02:04:10.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.192113 28350 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Bootstrap starting.
02:04:10.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.194789 28351 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Bootstrap starting.
02:04:10.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.195552 28349 tablet_bootstrap.cc:654] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Neither blocks nor log segments found. Creating new log.
02:04:10.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.200165 28349 log.cc:826] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Log is configured to *not* fsync() on all Append() calls
02:04:10.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.201231 28350 tablet_bootstrap.cc:654] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Neither blocks nor log segments found. Creating new log.
02:04:10.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.201579 28351 tablet_bootstrap.cc:654] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Neither blocks nor log segments found. Creating new log.
02:04:10.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.204478 28351 log.cc:826] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Log is configured to *not* fsync() on all Append() calls
02:04:10.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.204540 28350 log.cc:826] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Log is configured to *not* fsync() on all Append() calls
02:04:10.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.209369 28349 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: No bootstrap required, opened a new log
02:04:10.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.210590 28349 ts_tablet_manager.cc:1403] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Time spent bootstrapping tablet: real 0.024s	user 0.012s	sys 0.007s
02:04:10.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.213155 28351 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: No bootstrap required, opened a new log
02:04:10.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.213163 28350 tablet_bootstrap.cc:492] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: No bootstrap required, opened a new log
02:04:10.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.213749 28351 ts_tablet_manager.cc:1403] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Time spent bootstrapping tablet: real 0.019s	user 0.006s	sys 0.012s
02:04:10.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.213757 28350 ts_tablet_manager.cc:1403] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Time spent bootstrapping tablet: real 0.022s	user 0.020s	sys 0.000s
02:04:10.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.232877 28349 raft_consensus.cc:359] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.233583 28349 raft_consensus.cc:385] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:10.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.233870 28349 raft_consensus.cc:740] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 04e047c67acc4b6c8a5d951935525757, State: Initialized, Role: FOLLOWER
02:04:10.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.234814 28349 consensus_queue.cc:260] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [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: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.239463 28349 ts_tablet_manager.cc:1434] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Time spent starting tablet: real 0.029s	user 0.019s	sys 0.008s
02:04:10.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.243285 28351 raft_consensus.cc:359] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.244925 28351 raft_consensus.cc:385] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:10.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.244498 28350 raft_consensus.cc:359] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.245458 28350 raft_consensus.cc:385] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
02:04:10.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.245664 28351 raft_consensus.cc:740] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7081b34a30494c3ab81a455204a02a4e, State: Initialized, Role: FOLLOWER
02:04:10.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.245960 28350 raft_consensus.cc:740] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4600b6a0596e4552b39c542ea626cfee, State: Initialized, Role: FOLLOWER
02:04:10.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.246912 28351 consensus_queue.cc:260] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [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: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.247378 28350 consensus_queue.cc:260] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [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: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.255067 28351 ts_tablet_manager.cc:1434] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Time spent starting tablet: real 0.041s	user 0.034s	sys 0.004s
02:04:10.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.278002 28358 raft_consensus.cc:493] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
02:04:10.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.278642 28350 ts_tablet_manager.cc:1434] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Time spent starting tablet: real 0.065s	user 0.034s	sys 0.008s
02:04:10.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.280115 28358 raft_consensus.cc:515] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.296984 28358 leader_election.cc:290] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 7081b34a30494c3ab81a455204a02a4e (127.26.244.3:41395), 04e047c67acc4b6c8a5d951935525757 (127.26.244.2:41771)
02:04:10.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.321303 28130 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "dcd8ad3ba73e4cafaa9012ed440eaecc" candidate_uuid: "4600b6a0596e4552b39c542ea626cfee" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "04e047c67acc4b6c8a5d951935525757" is_pre_election: true
02:04:10.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.322093 28130 raft_consensus.cc:2468] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 4600b6a0596e4552b39c542ea626cfee in term 0.
02:04:10.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.322160 28270 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "dcd8ad3ba73e4cafaa9012ed440eaecc" candidate_uuid: "4600b6a0596e4552b39c542ea626cfee" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7081b34a30494c3ab81a455204a02a4e" is_pre_election: true
02:04:10.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.323360 28270 raft_consensus.cc:2468] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 4600b6a0596e4552b39c542ea626cfee in term 0.
02:04:10.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.323820 27923 leader_election.cc:304] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [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: 04e047c67acc4b6c8a5d951935525757, 4600b6a0596e4552b39c542ea626cfee; no voters: 
02:04:10.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.324575 28358 raft_consensus.cc:2804] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Leader pre-election won for term 1
02:04:10.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.324908 28358 raft_consensus.cc:493] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
02:04:10.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.325197 28358 raft_consensus.cc:3060] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 0 FOLLOWER]: Advancing to term 1
02:04:10.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:10.325874 28041 tablet.cc:2404] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:10.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.329949 28358 raft_consensus.cc:515] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.331396 28358 leader_election.cc:290] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [CANDIDATE]: Term 1 election: Requested vote from peers 7081b34a30494c3ab81a455204a02a4e (127.26.244.3:41395), 04e047c67acc4b6c8a5d951935525757 (127.26.244.2:41771)
02:04:10.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.332191 28270 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "dcd8ad3ba73e4cafaa9012ed440eaecc" candidate_uuid: "4600b6a0596e4552b39c542ea626cfee" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7081b34a30494c3ab81a455204a02a4e"
02:04:10.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.332437 28130 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "dcd8ad3ba73e4cafaa9012ed440eaecc" candidate_uuid: "4600b6a0596e4552b39c542ea626cfee" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "04e047c67acc4b6c8a5d951935525757"
02:04:10.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.332783 28270 raft_consensus.cc:3060] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 0 FOLLOWER]: Advancing to term 1
02:04:10.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.332962 28130 raft_consensus.cc:3060] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 0 FOLLOWER]: Advancing to term 1
02:04:10.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.340123 28270 raft_consensus.cc:2468] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4600b6a0596e4552b39c542ea626cfee in term 1.
02:04:10.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.340947 28130 raft_consensus.cc:2468] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4600b6a0596e4552b39c542ea626cfee in term 1.
02:04:10.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.341235 27923 leader_election.cc:304] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [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: 4600b6a0596e4552b39c542ea626cfee, 7081b34a30494c3ab81a455204a02a4e; no voters: 
02:04:10.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:10.341688 28322 tablet.cc:2404] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:10.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.341979 28358 raft_consensus.cc:2804] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 1 FOLLOWER]: Leader election won for term 1
02:04:10.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.342465 28358 raft_consensus.cc:697] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [term 1 LEADER]: Becoming Leader. State: Replica: 4600b6a0596e4552b39c542ea626cfee, State: Running, Role: LEADER
02:04:10.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 02:04:10.343425 28182 tablet.cc:2404] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757: Can't schedule compaction. Clean time has not been advanced past its initial value.
02:04:10.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.344313 28358 consensus_queue.cc:237] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [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: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } }
02:04:10.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.357438 27801 catalog_manager.cc:5696] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee reported cstate change: term changed from 0 to 1, leader changed from <none> to 4600b6a0596e4552b39c542ea626cfee (127.26.244.1). New cstate: current_term: 1 leader_uuid: "4600b6a0596e4552b39c542ea626cfee" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "4600b6a0596e4552b39c542ea626cfee" member_type: VOTER last_known_addr { host: "127.26.244.1" port: 38965 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 } health_report { overall_health: UNKNOWN } } }
02:04:10.527 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2538) Learned about tablet dcd8ad3ba73e4cafaa9012ed440eaecc for table 'org.apache.kudu.client.TestHybridTime-1779069834037' with partition [<start>, <end>)
02:04:10.534 [DEBUG - kudu-nio-2] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc@[04e047c67acc4b6c8a5d951935525757(127.26.244.2:41771),4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)[L],7081b34a30494c3ab81a455204a02a4e(127.26.244.3:41395)]}]
02:04:10.536 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=21), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.26.244.60:37121, [11ms] Sub RPC GetTableLocations: received response from server master-127.26.244.60:37121: OK, deferred=null) after lookup
02:04:10.548 [DEBUG - kudu-nio-2] (Connection.java:748) [peer 4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)] connecting to peer
02:04:10.554 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)] Successfully connected to peer
02:04:10.634 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x50dbebd6, L:/127.0.0.1:57184 - R:/127.26.244.1:38965] using TOKEN/null
02:04:10.651 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.651073 28130 raft_consensus.cc:1275] T dcd8ad3ba73e4cafaa9012ed440eaecc P 04e047c67acc4b6c8a5d951935525757 [term 1 FOLLOWER]: Refusing update from remote peer 4600b6a0596e4552b39c542ea626cfee: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:04:10.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.651813 28270 raft_consensus.cc:1275] T dcd8ad3ba73e4cafaa9012ed440eaecc P 7081b34a30494c3ab81a455204a02a4e [term 1 FOLLOWER]: Refusing update from remote peer 4600b6a0596e4552b39c542ea626cfee: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
02:04:10.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.652818 28357 consensus_queue.cc:1048] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [LEADER]: Connected to new peer: Peer: permanent_uuid: "04e047c67acc4b6c8a5d951935525757" member_type: VOTER last_known_addr { host: "127.26.244.2" port: 41771 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.001s
02:04:10.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.653627 28358 consensus_queue.cc:1048] T dcd8ad3ba73e4cafaa9012ed440eaecc P 4600b6a0596e4552b39c542ea626cfee [LEADER]: Connected to new peer: Peer: permanent_uuid: "7081b34a30494c3ab81a455204a02a4e" member_type: VOTER last_known_addr { host: "127.26.244.3" port: 41395 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
02:04:10.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.687122 28365 mvcc.cc:204] Tried to move back new op lower bound from 7287070108247068672 to 7287070107020746752. Current Snapshot: MvccSnapshot[applied={T|T < 7287070108247068672}]
02:04:10.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:10.704712 28366 mvcc.cc:204] Tried to move back new op lower bound from 7287070108247068672 to 7287070107020746752. Current Snapshot: MvccSnapshot[applied={T|T < 7287070108247068672}]
02:04:10.771 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.796 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.814 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.820 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@2027518319(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:04:10.839 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.840 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1701334695(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:04:10.859 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.860 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@448285597(state=PENDING, result=null, callback=<none>, errback=<none>)}
02:04:10.880 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
02:04:10.936 [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-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:10.950 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7287070128727068673) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:10.962 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7287070128727068677) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:10.973 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7287070128727068681) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:10.989 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7287070128727068685) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:11.003 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7287070128727068691) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:11.016 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7287070128727068695) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:11.027 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7287070128727068696) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1779069834037, tablet=dcd8ad3ba73e4cafaa9012ed440eaecc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
02:04:11.035 [DEBUG - main] (Connection.java:575) [peer master-127.26.244.62:44063(127.26.244.62:44063)] disconnecting while in state READY
02:04:11.037 [DEBUG - main] (Connection.java:575) [peer master-127.26.244.60:37121(127.26.244.60:37121)] disconnecting while in state READY
02:04:11.043 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.26.244.60:37121(127.26.244.60:37121)] handling channelInactive
02:04:11.044 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.26.244.62:44063(127.26.244.62:44063)] handling channelInactive
02:04:11.044 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.26.244.62:44063(127.26.244.62:44063)] cleaning up while in state READY due to: connection closed
02:04:11.045 [DEBUG - main] (Connection.java:575) [peer master-127.26.244.61:33667(127.26.244.61:33667)] disconnecting while in state READY
02:04:11.045 [DEBUG - main] (Connection.java:575) [peer 4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)] disconnecting while in state READY
02:04:11.046 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.26.244.61:33667(127.26.244.61:33667)] handling channelInactive
02:04:11.047 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.26.244.61:33667(127.26.244.61:33667)] cleaning up while in state READY due to: connection closed
02:04:11.047 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)] handling channelInactive
02:04:11.047 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 4600b6a0596e4552b39c542ea626cfee(127.26.244.1:38965)] cleaning up while in state READY due to: connection closed
02:04:11.055 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.26.244.60:37121(127.26.244.60:37121)] cleaning up while in state READY due to: connection closed
02:04:11.056 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
02:04:11.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.084478 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 27883
02:04:11.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.125927 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 28040
02:04:11.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.155110 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 28185
02:04:11.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.182767 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 27613
02:04:11.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.212847 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 27683
02:04:11.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 02:04:11.238298 27600 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task_AskSq/build/tsan/bin/kudu with pid 27758
02:04:12.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T02:04:12Z chronyd exiting

Time: 19.552

OK (1 test)

