JUnit version 4.13.2
.18:29:53.803 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783535393796
18:29:53.847 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:29:53.885 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:29:53.896 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task71JIGp/test-tmp
18:29:53.920 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/tsan/bin
18:29:53.923 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task71JIGp/java/build/dist-test/../../../build/tsan/bin/kudu, test, mini_cluster, --serialization=pb]
18:29:54.153 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:29:54.342 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:29:54.344 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:29:54.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.349131  9040 mini_oidc.cc:150] Starting JWKS server
18:29:54.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.353907  9040 webserver.cc:534] Webserver started at http://127.0.0.1:38765/ using document root <none> and password file <none>
18:29:54.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.354616  9040 mini_oidc.cc:186] Starting OIDC Discovery server
18:29:54.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.357053  9040 webserver.cc:534] Webserver started at http://127.0.0.1:41543/ using document root <none> and password file <none>
18:29:54.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:29:54Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:29:54.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:29:54Z Disabled control of system clock
18:29:54.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.416664  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:54.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:54.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal
18:29:54.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data
18:29:54.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:54.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:54.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:54.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:54.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:54.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:54.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/logs
18:29:54.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data/info.pb
18:29:54.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:54.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:54.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:54.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:54.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:54.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:54.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:54.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:54.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:54.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:54.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:54.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:54.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.62:33169
18:29:54.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.62
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:54.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:54.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:54.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:54.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json with env {}
18:29:54.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.711097  9052 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:54.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.711649  9052 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:54.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.712335  9052 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:54.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.744629  9052 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:54.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.744921  9052 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:54.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.745119  9052 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:54.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.745311  9052 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:54.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.745497  9052 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:54.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.745649  9052 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38765/jwks.json
18:29:54.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.781692  9052 master_runner.cc:387] Master server non-default flags:
18:29:54.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:54.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.62:33169
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:54.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data/info.pb
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.62
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:54.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/logs
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:29:54.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:29:54.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:29:54.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:29:54.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:29:54.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:29:54.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:29:54.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:29:54.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.783228  9052 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:29:54.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:54.785032  9052 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:29:54.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.798053  9059 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:56.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.200410  9057 debug-util.cc:398] Leaking SignalData structure 0x7b0800028020 after lost signal to thread 9052
18:29:56.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.350148  9057 kernel_stack_watchdog.cc:198] Thread 9052 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 400ms:
18:29:56.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
18:29:56.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
18:29:56.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
18:29:56.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
18:29:56.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.350246  9052 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.553s	user 0.660s	sys 0.892s
18:29:56.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.350620  9052 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.553s	user 0.661s	sys 0.892s
18:29:56.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:54.798122  9058 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:56.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.352815  9061 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:56.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.355280  9060 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1554 milliseconds
18:29:56.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.355299  9052 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
18:29:56.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.356590  9052 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:29:56.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.358992  9052 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:29:56.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.360333  9052 hybrid_clock.cc:648] HybridClock initialized: now 1783535396360288 us; error 39 us; skew 500 ppm
18:29:56.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.361193  9052 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:29:56.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.366879  9052 webserver.cc:534] Webserver started at http://127.8.212.62:35647/ using document root <none> and password file <none>
18:29:56.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.367872  9052 fs_manager.cc:362] Metadata directory not provided
18:29:56.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.368098  9052 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:29:56.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.368659  9052 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:29:56.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.373459  9052 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data/instance:
18:29:56.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1"
18:29:56.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:56 on dist-test-slave-6705"
18:29:56.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.375200  9052 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal/instance:
18:29:56.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1"
18:29:56.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:56 on dist-test-slave-6705"
18:29:56.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.382380  9052 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.000s
18:29:56.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.387766  9068 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:29:56.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.389051  9052 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.000s	sys 0.005s
18:29:56.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.389451  9052 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal
18:29:56.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1"
18:29:56.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:56 on dist-test-slave-6705"
18:29:56.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.389918  9052 fs_report.cc:389] FS layout report
18:29:56.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data/data
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:29:56.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:29:56.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:29:56.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:29:56.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:29:56.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.444324  9052 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:29:56.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.445889  9052 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:29:56.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.446373  9052 kserver.cc:163] Server-wide thread pool size limit: 3276
18:29:56.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.515846  9052 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.62:33169
18:29:56.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.515980  9119 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.62:33169 every 8 connection(s)
18:29:56.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.518875  9052 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/data/info.pb
18:29:56.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.524681  9120 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:29:56.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.525657  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9052
18:29:56.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.525992  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-0/wal/instance
18:29:56.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.529134  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal
18:29:56.535 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/logs
18:29:56.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data/info.pb
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:56.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.61:36013
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.61
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:56.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:56.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json with env {}
18:29:56.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.534907  9120 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } has no permanent_uuid. Determining permanent_uuid...
18:29:56.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.571062  9120 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } has no permanent_uuid. Determining permanent_uuid...
18:29:56.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.574143  9071 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:56.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.578260  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:56.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.627715  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 1
18:29:56.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.632329  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:56.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.700714  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 2
18:29:56.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.704775  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:56.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.796133  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 3
18:29:56.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.800156  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:56.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.827595  9122 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:56.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.828130  9122 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:56.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.828727  9122 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:56.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.859797  9122 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:56.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.860078  9122 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:56.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.860270  9122 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:56.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.860469  9122 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:56.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.860651  9122 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:56.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.860803  9122 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38765/jwks.json
18:29:56.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.897692  9122 master_runner.cc:387] Master server non-default flags:
18:29:56.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:56.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:56.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:56.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:56.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data
18:29:56.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal
18:29:56.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:56.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.61:36013
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:56.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data/info.pb
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.61
18:29:56.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:56.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/logs
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:29:56.903 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:29:56.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:29:56.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:29:56.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:29:56.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.898959  9122 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:29:56.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.900533  9122 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:29:56.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.913493  9131 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:56.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:56.943531  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 4
18:29:56.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.949131  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:57.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.248608  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 5
18:29:57.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.254276  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:57.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:57.801836  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 6
18:29:57.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:57.813990  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.61:36013: Network error: Client connection negotiation failed: client connection to 127.8.212.61:36013: connect: Connection refused (error 111)
18:29:58.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:56.915917  9132 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:58.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.034713  9134 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:58.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.036521  9122 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.123s	user 0.479s	sys 0.643s
18:29:58.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.036792  9122 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.123s	user 0.479s	sys 0.643s
18:29:58.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.036957  9122 server_base.cc:1061] running on GCE node
18:29:58.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.037992  9122 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:29:58.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.040741  9122 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:29:58.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.042158  9122 hybrid_clock.cc:648] HybridClock initialized: now 1783535398042109 us; error 61 us; skew 500 ppm
18:29:58.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.043077  9122 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:29:58.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.050063  9122 webserver.cc:534] Webserver started at http://127.8.212.61:33783/ using document root <none> and password file <none>
18:29:58.051 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.051352  9122 fs_manager.cc:362] Metadata directory not provided
18:29:58.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.051573  9122 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:29:58.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.052649  9122 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:29:58.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.057050  9122 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data/instance:
18:29:58.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0deb929654434502b9a63485527b0e58"
18:29:58.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:58 on dist-test-slave-6705"
18:29:58.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.058331  9122 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal/instance:
18:29:58.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0deb929654434502b9a63485527b0e58"
18:29:58.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:58 on dist-test-slave-6705"
18:29:58.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.066131  9122 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.003s	sys 0.003s
18:29:58.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.071997  9143 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:29:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.073185  9122 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.003s	sys 0.002s
18:29:58.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.073520  9122 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal
18:29:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0deb929654434502b9a63485527b0e58"
18:29:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:58 on dist-test-slave-6705"
18:29:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.073911  9122 fs_report.cc:389] FS layout report
18:29:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:29:58.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data/data
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:29:58.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:29:58.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:29:58.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.142035  9122 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:29:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.143844  9122 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:29:58.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.144340  9122 kserver.cc:163] Server-wide thread pool size limit: 3276
18:29:58.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.215152  9122 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.61:36013
18:29:58.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.215235  9194 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.61:36013 every 8 connection(s)
18:29:58.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.217897  9122 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/data/info.pb
18:29:58.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.223666  9195 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:29:58.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.225157  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9122
18:29:58.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.225587  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-1/wal/instance
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.227756  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:29:58.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/logs
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data/info.pb
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:29:58.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.60:40489
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.60
18:29:58.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:58.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json with env {}
18:29:58.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.236156  9195 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } has no permanent_uuid. Determining permanent_uuid...
18:29:58.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.258093  9195 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } has no permanent_uuid. Determining permanent_uuid...
18:29:58.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.272590  9195 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } has no permanent_uuid. Determining permanent_uuid...
18:29:58.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.275116  9147 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.279733  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.329263  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 1
18:29:58.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.334146  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.402577  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 2
18:29:58.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.406821  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.498294  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 3
18:29:58.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.502338  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.542732  9197 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:29:58.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.543443  9197 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:29:58.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.544098  9197 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:29:58.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.575903  9197 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:29:58.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.576247  9197 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:29:58.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.576577  9197 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:29:58.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.576930  9197 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:29:58.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.577291  9197 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:29:58.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.577559  9197 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:38765/jwks.json
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.612645  9197 master_runner.cc:387] Master server non-default flags:
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:29:58.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:29:58.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.60:40489
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:38765/jwks.json
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:29:58.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data/info.pb
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.60
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:29:58.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/logs
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:29:58.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:29:58.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:29:58.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:29:58.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:29:58.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.614300  9197 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:29:58.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.616654  9197 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:29:58.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.627782  9207 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:58.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.645830  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 4
18:29:58.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.652614  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.874492  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } attempt: 7
18:29:58.918 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.917963  9120 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } has no permanent_uuid. Determining permanent_uuid...
18:29:58.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.933521  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.952055  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 5
18:29:58.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.962296  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:58.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:58.991986  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 1
18:29:58.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.998692  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.080132  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 2
18:29:59.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.094899  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.180361  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 3
18:29:59.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.187268  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.327760  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 4
18:29:59.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.334674  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.509799  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 6
18:29:59.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.555058  9195 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.618160  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 5
18:29:59.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.626853  9120 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.8.212.60:40489: Network error: Client connection negotiation failed: client connection to 127.8.212.60:40489: connect: Connection refused (error 111)
18:29:59.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:58.628509  9208 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:59.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.949266  9210 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:29:59.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.952628  9209 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1323 milliseconds
18:29:59.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.953548  9197 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.326s	user 0.471s	sys 0.835s
18:29:59.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:29:59.953863  9197 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.327s	user 0.471s	sys 0.835s
18:29:59.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.954126  9197 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
18:29:59.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.955566  9197 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:29:59.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.958519  9197 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:29:59.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.960199  9197 hybrid_clock.cc:648] HybridClock initialized: now 1783535399960159 us; error 32 us; skew 500 ppm
18:29:59.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.961232  9197 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:29:59.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.969910  9197 webserver.cc:534] Webserver started at http://127.8.212.60:37491/ using document root <none> and password file <none>
18:29:59.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.970881  9197 fs_manager.cc:362] Metadata directory not provided
18:29:59.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.971088  9197 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:29:59.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.971545  9197 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:29:59.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.975759  9197 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data/instance:
18:29:59.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "884632be83c546b2a66801109d6e52f1"
18:29:59.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-6705"
18:29:59.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.976747  9197 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal/instance:
18:29:59.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "884632be83c546b2a66801109d6e52f1"
18:29:59.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-6705"
18:29:59.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.983711  9197 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.006s	sys 0.002s
18:29:59.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.989557  9222 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.990753  9197 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.001s
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.991111  9197 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "884632be83c546b2a66801109d6e52f1"
18:29:59.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:29:59 on dist-test-slave-6705"
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:29:59.991457  9197 fs_report.cc:389] FS layout report
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data/data
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:29:59.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:29:59.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:00.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.059991  9197 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:00.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.061822  9197 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:30:00.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.062319  9197 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:00.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.128685  9197 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.60:40489
18:30:00.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.128906  9273 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.60:40489 every 8 connection(s)
18:30:00.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.131546  9197 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/data/info.pb
18:30:00.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.136809  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9197
18:30:00.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.137202  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/master-2/wal/instance
18:30:00.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.138859  9274 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:00.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.154497  9274 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } has no permanent_uuid. Determining permanent_uuid...
18:30:00.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.179299  9120 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 6
18:30:00.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.180217  9274 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } has no permanent_uuid. Determining permanent_uuid...
18:30:00.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.192369  9274 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } has no permanent_uuid. Determining permanent_uuid...
18:30:00.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.200531  9120 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: Bootstrap starting.
18:30:00.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.206504  9120 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: Neither blocks nor log segments found. Creating new log.
18:30:00.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.208679  9120 log.cc:826] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: Log is configured to *not* fsync() on all Append() calls
18:30:00.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.210389  9274 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: Bootstrap starting.
18:30:00.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.219813  9274 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: Neither blocks nor log segments found. Creating new log.
18:30:00.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.222306  9274 log.cc:826] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: Log is configured to *not* fsync() on all Append() calls
18:30:00.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.233541  9274 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: No bootstrap required, opened a new log
18:30:00.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.236526  9120 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: No bootstrap required, opened a new log
18:30:00.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.258265  9120 raft_consensus.cc:359] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.259013  9120 raft_consensus.cc:385] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:00.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.259301  9120 raft_consensus.cc:740] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 41d6cd4d7a564ebfa6ccdecde1e305c1, State: Initialized, Role: FOLLOWER
18:30:00.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.260500  9120 consensus_queue.cc:260] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.262668  9274 raft_consensus.cc:359] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.263703  9274 raft_consensus.cc:385] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:00.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.263924  9274 raft_consensus.cc:740] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 884632be83c546b2a66801109d6e52f1, State: Initialized, Role: FOLLOWER
18:30:00.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.264765  9274 consensus_queue.cc:260] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.265156  9285 sys_catalog.cc:455] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.266141  9285 sys_catalog.cc:458] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.266945  9120 sys_catalog.cc:565] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: configured and running, proceeding with master startup.
18:30:00.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.267406  9286 sys_catalog.cc:455] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.268174  9286 sys_catalog.cc:458] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.268923  9274 sys_catalog.cc:565] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: configured and running, proceeding with master startup.
18:30:00.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.300088  9308 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:30:00.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.301940  9308 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:30:00.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.317222  9228 tablet.cc:2406] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:00.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.320632  9307 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:30:00.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.321389  9307 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:30:00.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.306996  9052 master_runner.cc:187] Error getting master registration for 127.8.212.61:36013: OK, instance_id { permanent_uuid: "0deb929654434502b9a63485527b0e58" instance_seqno: 1783535398195870 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:30:00.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.339449  9286 raft_consensus.cc:493] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:30:00.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.340013  9286 raft_consensus.cc:515] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.342617  9286 leader_election.cc:290] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 41d6cd4d7a564ebfa6ccdecde1e305c1 (127.8.212.62:33169), 0deb929654434502b9a63485527b0e58 (127.8.212.61:36013)
18:30:00.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.344007  9052 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:30:00.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.344075  9095 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "884632be83c546b2a66801109d6e52f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" is_pre_election: true
18:30:00.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.345786  9095 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 884632be83c546b2a66801109d6e52f1 in term 0.
18:30:00.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.304560  9197 master_runner.cc:187] Error getting master registration for 127.8.212.61:36013: OK, instance_id { permanent_uuid: "0deb929654434502b9a63485527b0e58" instance_seqno: 1783535398195870 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:30:00.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.349479  9197 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:30:00.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.350509  9224 leader_election.cc:304] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [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: 41d6cd4d7a564ebfa6ccdecde1e305c1, 884632be83c546b2a66801109d6e52f1; no voters: 
18:30:00.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.351411  9286 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:30:00.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.351754  9286 raft_consensus.cc:493] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:30:00.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.352067  9286 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 0 FOLLOWER]: Advancing to term 1
18:30:00.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.358546  9286 raft_consensus.cc:515] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.361052  9286 leader_election.cc:290] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [CANDIDATE]: Term 1 election: Requested vote from peers 41d6cd4d7a564ebfa6ccdecde1e305c1 (127.8.212.62:33169), 0deb929654434502b9a63485527b0e58 (127.8.212.61:36013)
18:30:00.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.363188  9095 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "884632be83c546b2a66801109d6e52f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1"
18:30:00.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.363747  9095 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 0 FOLLOWER]: Advancing to term 1
18:30:00.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.370399  9095 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 884632be83c546b2a66801109d6e52f1 in term 1.
18:30:00.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.371869  9224 leader_election.cc:304] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [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: 41d6cd4d7a564ebfa6ccdecde1e305c1, 884632be83c546b2a66801109d6e52f1; no voters: 
18:30:00.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.372684  9286 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 1 FOLLOWER]: Leader election won for term 1
18:30:00.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.375443  9286 raft_consensus.cc:697] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [term 1 LEADER]: Becoming Leader. State: Replica: 884632be83c546b2a66801109d6e52f1, State: Running, Role: LEADER
18:30:00.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.377529  9286 consensus_queue.cc:237] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.398087  9311 sys_catalog.cc:455] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 884632be83c546b2a66801109d6e52f1. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.398949  9311 sys_catalog.cc:458] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: This master's current role is: LEADER
18:30:00.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.432297  9313 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
18:30:00.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.439791  9313 catalog_manager.cc:1519] Initializing Kudu cluster ID...
18:30:00.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:00.456146  9074 tablet.cc:2406] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:30:00.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.483482  9095 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [term 1 FOLLOWER]: Refusing update from remote peer 884632be83c546b2a66801109d6e52f1: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:30:00.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.485283  9311 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [LEADER]: Connected to new peer: Peer: permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:00.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.535838  9285 sys_catalog.cc:455] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 884632be83c546b2a66801109d6e52f1. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.536579  9285 sys_catalog.cc:458] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.547554  9314 mvcc.cc:204] Tried to move back new op lower bound from 7305361000332079104 to 7305360999958810624. Current Snapshot: MvccSnapshot[applied={T|T < 7305361000332079104}]
18:30:00.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.552078  9315 mvcc.cc:204] Tried to move back new op lower bound from 7305361000332079104 to 7305360999958810624. Current Snapshot: MvccSnapshot[applied={T|T < 7305361000332079104}]
18:30:00.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.560431  9286 sys_catalog.cc:455] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.561151  9286 sys_catalog.cc:458] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: This master's current role is: LEADER
18:30:00.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.570560  9285 sys_catalog.cc:455] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.571273  9285 sys_catalog.cc:458] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.577229  9313 catalog_manager.cc:1382] Generated new cluster ID: 46fd0a9dc7f3486db50095a0253a9828
18:30:00.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.577538  9313 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
18:30:00.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.615552  9195 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } attempt: 7
18:30:00.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.649106  9195 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: Bootstrap starting.
18:30:00.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.668803  9195 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: Neither blocks nor log segments found. Creating new log.
18:30:00.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.672170  9195 log.cc:826] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: Log is configured to *not* fsync() on all Append() calls
18:30:00.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.675904  9313 catalog_manager.cc:1405] Generated new certificate authority record
18:30:00.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.678123  9313 catalog_manager.cc:1539] Loading token signing keys...
18:30:00.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.683847  9195 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: No bootstrap required, opened a new log
18:30:00.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.705399  9313 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1: Generated new TSK 0
18:30:00.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.709298  9313 catalog_manager.cc:1549] Initializing in-progress tserver states...
18:30:00.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.728390  9195 raft_consensus.cc:359] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.729692  9195 raft_consensus.cc:385] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:00.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.730031  9195 raft_consensus.cc:740] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0deb929654434502b9a63485527b0e58, State: Initialized, Role: FOLLOWER
18:30:00.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.733229  9195 consensus_queue.cc:260] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } }
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.746625  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:00.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/logs
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data/info.pb
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:00.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.1:0
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.1
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.1
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:00.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:00.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.753695  9195 sys_catalog.cc:565] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: configured and running, proceeding with master startup.
18:30:00.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.754263  9168 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [term 0 FOLLOWER]: Advancing to term 1
18:30:00.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.756160  9169 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "884632be83c546b2a66801109d6e52f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0deb929654434502b9a63485527b0e58"
18:30:00.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.750221  9321 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [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: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.758157  9321 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.758845  9170 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "884632be83c546b2a66801109d6e52f1" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0deb929654434502b9a63485527b0e58" is_pre_election: true
18:30:00.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.771293  9168 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [term 1 FOLLOWER]: Refusing update from remote peer 884632be83c546b2a66801109d6e52f1: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:30:00.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.774812  9311 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [LEADER]: Connected to new peer: Peer: permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:30:00.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.869194  9331 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.870075  9331 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: This master's current role is: FOLLOWER
18:30:00.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.871582  9321 sys_catalog.cc:455] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 884632be83c546b2a66801109d6e52f1. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:00.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.873433  9339 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
18:30:00.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:00.872268  9321 sys_catalog.cc:458] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58 [sys.catalog]: This master's current role is: FOLLOWER
18:30:01.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.160382  9311 sys_catalog.cc:455] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "884632be83c546b2a66801109d6e52f1" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "41d6cd4d7a564ebfa6ccdecde1e305c1" member_type: VOTER last_known_addr { host: "127.8.212.62" port: 33169 } } peers { permanent_uuid: "0deb929654434502b9a63485527b0e58" member_type: VOTER last_known_addr { host: "127.8.212.61" port: 36013 } } peers { permanent_uuid: "884632be83c546b2a66801109d6e52f1" member_type: VOTER last_known_addr { host: "127.8.212.60" port: 40489 } } }
18:30:01.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.161219  9311 sys_catalog.cc:458] T 00000000000000000000000000000000 P 884632be83c546b2a66801109d6e52f1 [sys.catalog]: This master's current role is: LEADER
18:30:01.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.327379  9307 catalog_manager.cc:1294] Loaded cluster ID: 46fd0a9dc7f3486db50095a0253a9828
18:30:01.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.328181  9307 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: loading cluster ID for follower catalog manager: success
18:30:01.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.335575  9307 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: acquiring CA information for follower catalog manager: success
18:30:01.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.341213  9307 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 41d6cd4d7a564ebfa6ccdecde1e305c1: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:30:01.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.379719  9324 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:01.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.380404  9324 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:01.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.381129  9324 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:01.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.440982  9324 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:01.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.442339  9324 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.212.1
18:30:01.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.506294  9324 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.1:0
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:01.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data/info.pb
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.1
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.1
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/logs
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:01.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:01.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:01.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:01.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.508026  9324 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:01.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.510128  9324 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:01.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.568794  9345 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:01.895 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.895123  9339 catalog_manager.cc:1294] Loaded cluster ID: 46fd0a9dc7f3486db50095a0253a9828
18:30:01.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.896122  9339 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: loading cluster ID for follower catalog manager: success
18:30:01.904 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.904254  9339 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: acquiring CA information for follower catalog manager: success
18:30:01.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:01.920424  9339 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 0deb929654434502b9a63485527b0e58: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:30:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:02.948916  9344 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 9324
18:30:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.645902  9324 thread.cc:641] GCE (cloud detector) Time spent creating pthread: real 2.069s	user 0.884s	sys 1.056s
18:30:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.646270  9324 thread.cc:608] GCE (cloud detector) Time spent starting thread: real 2.070s	user 0.884s	sys 1.056s
18:30:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:01.583104  9346 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:03.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:03.655200  9350 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:03.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.655277  9324 server_base.cc:1061] running on GCE node
18:30:03.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.657320  9324 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:03.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.659798  9324 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:03.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.661238  9324 hybrid_clock.cc:648] HybridClock initialized: now 1783535403661073 us; error 157 us; skew 500 ppm
18:30:03.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.662299  9324 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:03.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.669325  9324 webserver.cc:534] Webserver started at http://127.8.212.1:46451/ using document root <none> and password file <none>
18:30:03.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.670521  9324 fs_manager.cc:362] Metadata directory not provided
18:30:03.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.670811  9324 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:03.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.671348  9324 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:03.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.677883  9324 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data/instance:
18:30:03.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f6222f97414438290465cffe7ab6981"
18:30:03.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:03 on dist-test-slave-6705"
18:30:03.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.679450  9324 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal/instance:
18:30:03.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f6222f97414438290465cffe7ab6981"
18:30:03.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:03 on dist-test-slave-6705"
18:30:03.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.688635  9324 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.008s	sys 0.000s
18:30:03.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.696585  9356 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:03.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.698594  9324 fs_manager.cc:730] Time spent opening block manager: real 0.006s	user 0.006s	sys 0.000s
18:30:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.698987  9324 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal
18:30:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2f6222f97414438290465cffe7ab6981"
18:30:03.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:03 on dist-test-slave-6705"
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.699406  9324 fs_report.cc:389] FS layout report
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data/data
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:03.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:03.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.766695  9324 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:03.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.768144  9324 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:30:03.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.768571  9324 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.771245  9324 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:03.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.775434  9324 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:03.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.775645  9324 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:03.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.775939  9324 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:03.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.776129  9324 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:03.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.941416  9324 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.1:40069
18:30:03.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.941512  9468 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.1:40069 every 8 connection(s)
18:30:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.944115  9324 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/data/info.pb
18:30:03.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.946470  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9324
18:30:03.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.946942  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-0/wal/instance
18:30:03.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:03.964183  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:03.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:03.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal
18:30:03.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/logs
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data/info.pb
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:03.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.2:0
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.2
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.2
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:03.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:04.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.003628  9469 heartbeater.cc:344] Connected to a master server at 127.8.212.60:40489
18:30:04.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.004743  9469 heartbeater.cc:461] Registering TS with master...
18:30:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.006163  9469 heartbeater.cc:507] Master 127.8.212.60:40489 requested a full tablet report, sending...
18:30:04.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.010458  9239 ts_manager.cc:194] Registered new tserver with Master: 2f6222f97414438290465cffe7ab6981 (127.8.212.1:40069)
18:30:04.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.013234  9239 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.212.1:44123
18:30:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.023015  9470 heartbeater.cc:344] Connected to a master server at 127.8.212.61:36013
18:30:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.023379  9470 heartbeater.cc:461] Registering TS with master...
18:30:04.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.023991  9470 heartbeater.cc:507] Master 127.8.212.61:36013 requested a full tablet report, sending...
18:30:04.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.028007  9160 ts_manager.cc:194] Registered new tserver with Master: 2f6222f97414438290465cffe7ab6981 (127.8.212.1:40069)
18:30:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.030812  9474 heartbeater.cc:344] Connected to a master server at 127.8.212.62:33169
18:30:04.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.031114  9474 heartbeater.cc:461] Registering TS with master...
18:30:04.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.031687  9474 heartbeater.cc:507] Master 127.8.212.62:33169 requested a full tablet report, sending...
18:30:04.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.034395  9084 ts_manager.cc:194] Registered new tserver with Master: 2f6222f97414438290465cffe7ab6981 (127.8.212.1:40069)
18:30:04.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.377562  9473 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:04.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.378098  9473 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:04.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.378701  9473 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:04.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.411424  9473 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:04.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.412372  9473 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.212.2
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.454521  9473 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.2:0
18:30:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:04.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data/info.pb
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.2
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.2
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/logs
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:04.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.456261  9473 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:04.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:04.458557  9473 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:04.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.472582  9486 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:05.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:05.020767  9469 heartbeater.cc:499] Master 127.8.212.60:40489 was elected leader, sending a full tablet report...
18:30:06.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:05.874001  9485 debug-util.cc:398] Leaking SignalData structure 0x7b0800028000 after lost signal to thread 9473
18:30:06.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.236961  9485 kernel_stack_watchdog.cc:198] Thread 9473 stuck at /home/jenkins-slave/workspace/build_and_test@2/src/kudu/util/thread.cc:642 for 397ms:
18:30:06.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Kernel stack:
18:30:06.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) (could not read kernel stack)
18:30:06.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) User stack:
18:30:06.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) <Timed out: thread did not respond: maybe it is blocking signals>
18:30:06.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:04.473191  9487 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:06.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.242771  9473 thread.cc:641] OpenStack (cloud detector) Time spent creating pthread: real 1.769s	user 0.003s	sys 0.000s
18:30:06.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.243126  9473 thread.cc:608] OpenStack (cloud detector) Time spent starting thread: real 1.769s	user 0.003s	sys 0.000s
18:30:06.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.244253  9488 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1770 milliseconds
18:30:06.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.245445  9489 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:06.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.245522  9473 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
18:30:06.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.246920  9473 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:06.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.249302  9473 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:06.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.250876  9473 hybrid_clock.cc:648] HybridClock initialized: now 1783535406250834 us; error 35 us; skew 500 ppm
18:30:06.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.251873  9473 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:06.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.258883  9473 webserver.cc:534] Webserver started at http://127.8.212.2:39863/ using document root <none> and password file <none>
18:30:06.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.259752  9473 fs_manager.cc:362] Metadata directory not provided
18:30:06.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.259936  9473 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:06.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.260306  9473 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:06.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.265059  9473 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data/instance:
18:30:06.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5801c07c5f5040bea9863eed9a6a0252"
18:30:06.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:06 on dist-test-slave-6705"
18:30:06.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.266089  9473 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal/instance:
18:30:06.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5801c07c5f5040bea9863eed9a6a0252"
18:30:06.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:06 on dist-test-slave-6705"
18:30:06.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.273144  9473 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.005s	sys 0.000s
18:30:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.278374  9497 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:06.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.279340  9473 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.279654  9473 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5801c07c5f5040bea9863eed9a6a0252"
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:06 on dist-test-slave-6705"
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.279981  9473 fs_report.cc:389] FS layout report
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data/data
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:06.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.331449  9473 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:06.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.332918  9473 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:30:06.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.333371  9473 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:06.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.336050  9473 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:06.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.339910  9473 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:06.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.340132  9473 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:06.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.340449  9473 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:06.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.340642  9473 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:06.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.473969  9473 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.2:40339
18:30:06.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.474086  9609 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.2:40339 every 8 connection(s)
18:30:06.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.476523  9473 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/data/info.pb
18:30:06.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.477701  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9473
18:30:06.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.478332  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-1/wal/instance
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.491871  9040 external_mini_cluster.cc:1372] Running /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task71JIGp/build/tsan/bin/kudu
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:06.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/logs
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data/info.pb
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.3:0
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.3
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.3
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:06.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:30:06.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.540510  9612 heartbeater.cc:344] Connected to a master server at 127.8.212.62:33169
18:30:06.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.540990  9612 heartbeater.cc:461] Registering TS with master...
18:30:06.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.542164  9612 heartbeater.cc:507] Master 127.8.212.62:33169 requested a full tablet report, sending...
18:30:06.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.545301  9084 ts_manager.cc:194] Registered new tserver with Master: 5801c07c5f5040bea9863eed9a6a0252 (127.8.212.2:40339)
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.548120  9610 heartbeater.cc:344] Connected to a master server at 127.8.212.60:40489
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.548449  9610 heartbeater.cc:461] Registering TS with master...
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.549253  9610 heartbeater.cc:507] Master 127.8.212.60:40489 requested a full tablet report, sending...
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.550571  9611 heartbeater.cc:344] Connected to a master server at 127.8.212.61:36013
18:30:06.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.550884  9611 heartbeater.cc:461] Registering TS with master...
18:30:06.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.551358  9239 ts_manager.cc:194] Registered new tserver with Master: 5801c07c5f5040bea9863eed9a6a0252 (127.8.212.2:40339)
18:30:06.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.551782  9611 heartbeater.cc:507] Master 127.8.212.61:36013 requested a full tablet report, sending...
18:30:06.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.552646  9239 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.212.2:42065
18:30:06.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.560221  9160 ts_manager.cc:194] Registered new tserver with Master: 5801c07c5f5040bea9863eed9a6a0252 (127.8.212.2:40339)
18:30:06.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.808880  9620 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:30:06.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.809319  9620 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:30:06.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.809712  9620 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:30:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.842727  9620 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:30:06.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.843485  9620 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.8.212.3
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.879622  9620 tablet_server_runner.cc:78] Tablet server non-default flags:
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.8.212.20:44163
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.8.212.3:0
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data/info.pb
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.8.212.3
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.8.212.62:33169,127.8.212.61:36013,127.8.212.60:40489
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:30:06.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.8.212.3
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/logs
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 3ddc7d4404ac90c834b1cdd020973c286611e9b0
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 18:05:40 UTC on e7f111948823
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16871
18:30:06.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) TSAN enabled
18:30:06.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.881897  9620 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:30:06.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:06.883562  9620 file_cache.cc:492] Constructed file cache file cache with capacity 419430
18:30:06.896 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.895854  9627 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:07.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:07.556236  9610 heartbeater.cc:499] Master 127.8.212.60:40489 was elected leader, sending a full tablet report...
18:30:08.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:06.896576  9628 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:08.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.050340  9630 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:30:08.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 18:30:08.053912  9629 instance_detector.cc:116] could not retrieve GCE instance metadata: Timed out: curl timeout: Timeout was reached: Resolving timed out after 1152 milliseconds
18:30:08.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.054018  9620 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
18:30:08.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.055156  9620 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:30:08.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.057338  9620 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:30:08.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.058763  9620 hybrid_clock.cc:648] HybridClock initialized: now 1783535408058723 us; error 38 us; skew 500 ppm
18:30:08.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.059526  9620 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:30:08.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.065591  9620 webserver.cc:534] Webserver started at http://127.8.212.3:34207/ using document root <none> and password file <none>
18:30:08.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.066427  9620 fs_manager.cc:362] Metadata directory not provided
18:30:08.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.066686  9620 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:30:08.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.067245  9620 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:30:08.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.071498  9620 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data/instance:
18:30:08.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "209d27b8fd75408dbf910852331a51e8"
18:30:08.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-6705"
18:30:08.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.072599  9620 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal/instance:
18:30:08.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "209d27b8fd75408dbf910852331a51e8"
18:30:08.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-6705"
18:30:08.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.079569  9620 fs_manager.cc:696] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
18:30:08.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.085553  9637 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:30:08.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.086856  9620 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.002s	sys 0.000s
18:30:08.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.087214  9620 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data,/tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal
18:30:08.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "209d27b8fd75408dbf910852331a51e8"
18:30:08.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 18:30:08 on dist-test-slave-6705"
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.087560  9620 fs_report.cc:389] FS layout report
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data/data
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:30:08.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:30:08.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.144449  9620 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:30:08.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.146284  9620 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:30:08.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.146821  9620 kserver.cc:163] Server-wide thread pool size limit: 3276
18:30:08.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.149582  9620 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:30:08.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.153442  9620 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:30:08.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.153630  9620 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:30:08.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.153810  9620 ts_tablet_manager.cc:616] Registered 0 tablets
18:30:08.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.153949  9620 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:30:08.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.285902  9620 rpc_server.cc:307] RPC server started. Bound to: 127.8.212.3:35595
18:30:08.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.286051  9749 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.8.212.3:35595 every 8 connection(s)
18:30:08.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.288419  9620 server_base.cc:1193] Dumped server information to /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/data/info.pb
18:30:08.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.295954  9040 external_mini_cluster.cc:1434] Started /tmp/dist-test-task71JIGp/build/tsan/bin/kudu as pid 9620
18:30:08.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.296446  9040 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task71JIGp/test-tmp/mini-kudu-cluster12729320530300364086/ts-2/wal/instance
18:30:08.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.334154  9750 heartbeater.cc:344] Connected to a master server at 127.8.212.60:40489
18:30:08.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.334654  9750 heartbeater.cc:461] Registering TS with master...
18:30:08.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.335628  9751 heartbeater.cc:344] Connected to a master server at 127.8.212.61:36013
18:30:08.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.335959  9751 heartbeater.cc:461] Registering TS with master...
18:30:08.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.335909  9750 heartbeater.cc:507] Master 127.8.212.60:40489 requested a full tablet report, sending...
18:30:08.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.336803  9751 heartbeater.cc:507] Master 127.8.212.61:36013 requested a full tablet report, sending...
18:30:08.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.336881  9752 heartbeater.cc:344] Connected to a master server at 127.8.212.62:33169
18:30:08.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.337504  9752 heartbeater.cc:461] Registering TS with master...
18:30:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.338588  9239 ts_manager.cc:194] Registered new tserver with Master: 209d27b8fd75408dbf910852331a51e8 (127.8.212.3:35595)
18:30:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.338963  9752 heartbeater.cc:507] Master 127.8.212.62:33169 requested a full tablet report, sending...
18:30:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.339293  9160 ts_manager.cc:194] Registered new tserver with Master: 209d27b8fd75408dbf910852331a51e8 (127.8.212.3:35595)
18:30:08.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.340204  9239 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.8.212.3:45163
18:30:08.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.342381  9084 ts_manager.cc:194] Registered new tserver with Master: 209d27b8fd75408dbf910852331a51e8 (127.8.212.3:35595)
18:30:08.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:08.364306  9040 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:30:08.375 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:30:08.376 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:30:08.385 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.212.62"
      port: 33169
    }
    bound_http_address {
      host: "127.8.212.62"
      port: 35647
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.212.61"
      port: 36013
    }
    bound_http_address {
      host: "127.8.212.61"
      port: 33783
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.212.60"
      port: 40489
    }
    bound_http_address {
      host: "127.8.212.60"
      port: 37491
    }
  }
}

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

18:30:08.390 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.8.212.1"
      port: 40069
    }
    bound_http_address {
      host: "127.8.212.1"
      port: 46451
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.8.212.2"
      port: 40339
    }
    bound_http_address {
      host: "127.8.212.2"
      port: 39863
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.8.212.3"
      port: 35595
    }
    bound_http_address {
      host: "127.8.212.3"
      port: 34207
    }
  }
}

18:30:08.390 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:30:08.559 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
18:30:08.606 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:30:08.758 [DEBUG - main] (Connection.java:748) [peer master-127.8.212.60:40489(127.8.212.60:40489)] connecting to peer
18:30:08.815 [DEBUG - main] (Connection.java:748) [peer master-127.8.212.62:33169(127.8.212.62:33169)] connecting to peer
18:30:08.825 [DEBUG - main] (Connection.java:748) [peer master-127.8.212.61:36013(127.8.212.61:36013)] connecting to peer
18:30:08.834 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.8.212.62:33169(127.8.212.62:33169)] Successfully connected to peer
18:30:08.841 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.8.212.61:36013(127.8.212.61:36013)] Successfully connected to peer
18:30:08.841 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.8.212.60:40489(127.8.212.60:40489)] Successfully connected to peer
18:30:08.936 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.212.60
18:30:08.936 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.212.61
18:30:08.941 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.8.212.62
18:30:09.155 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xc1a2ba2c, L:/127.0.0.1:37924 - R:/127.8.212.62:33169] using SASL/PLAIN
18:30:09.157 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x2cf4bbb4, L:/127.0.0.1:54332 - R:/127.8.212.61:36013] using SASL/PLAIN
18:30:09.158 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x34824e3d, L:/127.0.0.1:55182 - R:/127.8.212.60:40489] using SASL/PLAIN
18:30:09.192 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:30:09.193 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=481), Traces: [0ms] refreshing cache from master, [30ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.212.60:40489, [99ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.212.62:33169, [107ms] Sub RPC ConnectToMaster: sending RPC to server master-127.8.212.61:36013, [455ms] Sub RPC ConnectToMaster: received response from server master-127.8.212.62:33169: OK, [455ms] Sub RPC ConnectToMaster: received response from server master-127.8.212.61:36013: OK, [456ms] Sub RPC ConnectToMaster: received response from server master-127.8.212.60:40489: OK, deferred=null) after lookup
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.245432  9239 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:55182:
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestStatistics-1783535393161"
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:30:09.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) num_replicas: 1
18:30:09.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:30:09.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:30:09.307 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table fbefe3a3715e4902b9e2e5c1f3693be8
18:30:09.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.337706  9685 tablet_service.cc:1511] Processing CreateTablet for tablet 3755bea9880944308d1f579927f34b58 (DEFAULT_TABLE table=org.apache.kudu.client.TestStatistics-1783535393161 [id=fbefe3a3715e4902b9e2e5c1f3693be8]), partition=RANGE (key) PARTITION UNBOUNDED
18:30:09.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.339790  9685 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 3755bea9880944308d1f579927f34b58. 1 dirs total, 0 dirs full, 0 dirs failed
18:30:09.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.343745  9750 heartbeater.cc:499] Master 127.8.212.60:40489 was elected leader, sending a full tablet report...
18:30:09.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.362313  9781 tablet_bootstrap.cc:492] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: Bootstrap starting.
18:30:09.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.367215  9781 tablet_bootstrap.cc:654] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: Neither blocks nor log segments found. Creating new log.
18:30:09.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.368798  9781 log.cc:826] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: Log is configured to *not* fsync() on all Append() calls
18:30:09.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.372709  9781 tablet_bootstrap.cc:492] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: No bootstrap required, opened a new log
18:30:09.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.373060  9781 ts_tablet_manager.cc:1403] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: Time spent bootstrapping tablet: real 0.011s	user 0.009s	sys 0.000s
18:30:09.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.390832  9781 raft_consensus.cc:359] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "209d27b8fd75408dbf910852331a51e8" member_type: VOTER last_known_addr { host: "127.8.212.3" port: 35595 } }
18:30:09.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.391350  9781 raft_consensus.cc:385] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:30:09.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.391535  9781 raft_consensus.cc:740] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 209d27b8fd75408dbf910852331a51e8, State: Initialized, Role: FOLLOWER
18:30:09.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.392285  9781 consensus_queue.cc:260] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [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: true peers { permanent_uuid: "209d27b8fd75408dbf910852331a51e8" member_type: VOTER last_known_addr { host: "127.8.212.3" port: 35595 } }
18:30:09.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.392971  9781 raft_consensus.cc:399] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
18:30:09.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.393406  9781 raft_consensus.cc:493] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
18:30:09.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.393744  9781 raft_consensus.cc:3060] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 0 FOLLOWER]: Advancing to term 1
18:30:09.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.398437  9781 raft_consensus.cc:515] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "209d27b8fd75408dbf910852331a51e8" member_type: VOTER last_known_addr { host: "127.8.212.3" port: 35595 } }
18:30:09.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.399303  9781 leader_election.cc:304] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 209d27b8fd75408dbf910852331a51e8; no voters: 
18:30:09.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.401171  9781 leader_election.cc:290] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [CANDIDATE]: Term 1 election: Requested vote from peers 
18:30:09.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.401544  9783 raft_consensus.cc:2804] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 1 FOLLOWER]: Leader election won for term 1
18:30:09.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.403723  9783 raft_consensus.cc:697] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [term 1 LEADER]: Becoming Leader. State: Replica: 209d27b8fd75408dbf910852331a51e8, State: Running, Role: LEADER
18:30:09.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.404524  9783 consensus_queue.cc:237] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 [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: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "209d27b8fd75408dbf910852331a51e8" member_type: VOTER last_known_addr { host: "127.8.212.3" port: 35595 } }
18:30:09.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.405007  9781 ts_tablet_manager.cc:1434] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8: Time spent starting tablet: real 0.032s	user 0.018s	sys 0.014s
18:30:09.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.421042  9239 catalog_manager.cc:5696] T 3755bea9880944308d1f579927f34b58 P 209d27b8fd75408dbf910852331a51e8 reported cstate change: term changed from 0 to 1, leader changed from <none> to 209d27b8fd75408dbf910852331a51e8 (127.8.212.3). New cstate: current_term: 1 leader_uuid: "209d27b8fd75408dbf910852331a51e8" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "209d27b8fd75408dbf910852331a51e8" member_type: VOTER last_known_addr { host: "127.8.212.3" port: 35595 } health_report { overall_health: HEALTHY } } }
18:30:09.457 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 3755bea9880944308d1f579927f34b58 for table 'org.apache.kudu.client.TestStatistics-1783535393161' with partition [<start>, <end>)
18:30:09.457 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@86258393(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.461 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299996, tablet=3755bea9880944308d1f579927f34b58@[209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)[L]]}]
18:30:09.466 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet 3755bea9880944308d1f579927f34b58 for table 'org.apache.kudu.client.TestStatistics-1783535393161' with partition [<start>, <end>)
18:30:09.466 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299999, tablet=3755bea9880944308d1f579927f34b58@[209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)[L]]}]
18:30:09.479 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)] connecting to peer
18:30:09.482 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)] Successfully connected to peer
18:30:09.554 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xf1fae5e1, L:/127.0.0.1:54940 - R:/127.8.212.3:35595] using TOKEN/null
18:30:09.599 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@444959113(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.616 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1041482490(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.627 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@492973509(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.638 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@79566332(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.648 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@843128099(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.658 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@317001091(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.668 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@509941279(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.679 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1786835418(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.690 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=2, operationSize=108, flusherTask=null, flushNotification=Deferred@1343373740(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:30:09.901 [DEBUG - main] (Connection.java:575) [peer master-127.8.212.61:36013(127.8.212.61:36013)] disconnecting while in state READY
18:30:09.902 [DEBUG - main] (Connection.java:575) [peer master-127.8.212.62:33169(127.8.212.62:33169)] disconnecting while in state READY
18:30:09.902 [DEBUG - main] (Connection.java:575) [peer 209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)] disconnecting while in state READY
18:30:09.902 [DEBUG - main] (Connection.java:575) [peer master-127.8.212.60:40489(127.8.212.60:40489)] disconnecting while in state READY
18:30:09.906 [DEBUG - kudu-nio-2] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:30:09.907 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.8.212.60:40489(127.8.212.60:40489)] handling channelInactive
18:30:09.908 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.8.212.60:40489(127.8.212.60:40489)] cleaning up while in state READY due to: connection closed
18:30:09.909 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.8.212.62:33169(127.8.212.62:33169)] handling channelInactive
18:30:09.909 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.8.212.62:33169(127.8.212.62:33169)] cleaning up while in state READY due to: connection closed
18:30:09.909 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.8.212.61:36013(127.8.212.61:36013)] handling channelInactive
18:30:09.910 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.8.212.61:36013(127.8.212.61:36013)] cleaning up while in state READY due to: connection closed
18:30:09.911 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)] handling channelInactive
18:30:09.911 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 209d27b8fd75408dbf910852331a51e8(127.8.212.3:35595)] cleaning up while in state READY due to: connection closed
18:30:09.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.911476  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9324
18:30:09.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.947182  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9473
18:30:09.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.975104  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9620
18:30:09.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:09.995409  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9052
18:30:10.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.018141  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9122
18:30:10.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 18:30:10.038646  9040 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task71JIGp/build/tsan/bin/kudu with pid 9197
18:30:11.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T18:30:11Z chronyd exiting

Time: 18.819

OK (1 test)

