JUnit version 4.13.2
.18:50:18.381 [INFO - main] (RandomUtils.java:49) Using random seed: 1786474218375
18:50:18.400 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:50:18.457 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:50:18.465 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskYhykuz/test-tmp
18:50:18.468 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
18:50:18.472 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskYhykuz/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
18:50:18.737 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932"
  extra_master_flags: "--authn_token_validity_seconds=1"
  extra_master_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--rpc_inject_invalid_authn_token_ratio=0.5"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:50:18.893 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:50:18.894 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:50:18.898 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:18.897982 27074 mini_oidc.cc:152] Starting JWKS server
18:50:18.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:18.900928 27074 webserver.cc:460] Webserver started at http://127.0.0.1:45761/ using document root <none> and password file <none>
18:50:18.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:18.901207 27074 mini_oidc.cc:189] Starting OIDC Discovery server
18:50:18.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:18.901921 27074 webserver.cc:460] Webserver started at http://127.0.0.1:41923/ using document root <none> and password file <none>
18:50:18.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
18:50:18.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/principal' for realm 'KRBTEST.COM',
18:50:18.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
18:50:18.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:18 dist-test-slave-gkw7 krb5kdc[27088](info): setting up network...
18:50:18.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
18:50:18.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:18 dist-test-slave-gkw7 krb5kdc[27088](info): set up 2 sockets
18:50:18.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:18 dist-test-slave-gkw7 krb5kdc[27088](info): commencing operation
18:50:18.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
18:50:20.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.408725 27074 mini_kdc.cc:121] Time spent starting KDC: real 1.498s	user 0.004s	sys 0.017s
18:50:20.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
18:50:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:50:20.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
18:50:20.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
18:50:20.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:50:20.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
18:50:20.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
18:50:20.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:50:20.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
18:50:20.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:50:20.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/test-user.keytab.
18:50:20.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/test-user.keytab.
18:50:20.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:20 dist-test-slave-gkw7 krb5kdc[27088](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:50:20.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
18:50:20.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:50:20Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
18:50:20.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:50:20Z Disabled control of system clock
18:50:20.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.112.190@KRBTEST.COM; defaulting to no policy
18:50:20.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:20.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.112.190@KRBTEST.COM" created.
18:50:20.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:20.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.190 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.190.keytab.
18:50:20.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.190 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.190.keytab.
18:50:20.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:20.627781 27074 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:20.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:20.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal
18:50:20.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data
18:50:20.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:50:20.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:50:20.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:50:20.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:20.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:20.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:20.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/logs
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data/info.pb
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:50:20.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:50:20.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:20.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:20.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:20.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:50:20.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.190:44687
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.190
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.190.keytab
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.190
18:50:20.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.112.190:44687
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45761/jwks.json
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
18:50:20.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:50:20.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.979322 27108 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:50:20.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.979622 27108 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:50:20.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.979729 27108 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:50:20.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987174 27108 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
18:50:20.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987289 27108 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
18:50:20.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987340 27108 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:50:20.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987393 27108 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
18:50:20.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987435 27108 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
18:50:20.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987490 27108 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
18:50:20.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:20.987524 27108 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:45761/jwks.json
18:50:20.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:20.997890 27108 master_runner.cc:386] Master server non-default flags:
18:50:20.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:20.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:20.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.26.112.190:44687
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.190.keytab
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.190
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:20.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.190:44687
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:45761/jwks.json
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:21.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data/info.pb
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.190
18:50:21.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:21.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:50:21.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:21.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:50:21.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:50:21.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/logs
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 16:09:54 UTC on ccycloud.quasar-hitlqc.root.comops.site
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580676
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
18:50:21.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:20.999747 27108 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:50:21.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.001694 27108 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:50:21.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.015095 27116 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:50:21.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.015192 27117 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:50:21.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.015116 27119 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:50:21.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.019237 27108 server_base.cc:1034] running on GCE node
18:50:21.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.020043 27108 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:50:21.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.021512 27108 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:50:21.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.022789 27108 hybrid_clock.cc:648] HybridClock initialized: now 1786474221022722 us; error 75 us; skew 500 ppm
18:50:21.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.023121 27108 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:50:21.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:21 dist-test-slave-gkw7 krb5kdc[27088](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474221, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.190@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:50:21.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.026705 27108 init.cc:377] Logged in from keytab as kudu/127.26.112.190@KRBTEST.COM (short username kudu)
18:50:21.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.028355 27108 webserver.cc:460] Webserver started at http://127.26.112.190:44593/ using document root <none> and password file <none>
18:50:21.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.029040 27108 fs_manager.cc:359] Metadata directory not provided
18:50:21.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.029145 27108 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:50:21.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.029490 27108 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:50:21.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.032469 27108 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data/instance:
18:50:21.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf0836d673f449d6a71048c4d4723cc4"
18:50:21.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.033215 27108 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal/instance:
18:50:21.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf0836d673f449d6a71048c4d4723cc4"
18:50:21.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.038852 27108 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.002s	sys 0.002s
18:50:21.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.042483 27130 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:50:21.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.044312 27108 fs_manager.cc:725] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
18:50:21.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.044497 27108 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data,/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal
18:50:21.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bf0836d673f449d6a71048c4d4723cc4"
18:50:21.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.044677 27108 fs_report.cc:383] FS layout report
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data/data
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:50:21.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:50:21.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:50:21.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.067996 27108 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:50:21.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.072769 27108 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:50:21.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.073047 27108 kserver.cc:163] Server-wide thread pool size limit: 3276
18:50:21.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.093431 27108 rpc_server.cc:307] RPC server started. Bound to: 127.26.112.190:44687
18:50:21.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.093465 27216 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.112.190:44687 every 8 connection(s)
18:50:21.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.095000 27108 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/data/info.pb
18:50:21.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.099386 27217 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:50:21.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.101197 27074 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskYhykuz/build/asan/bin/kudu as pid 27108
18:50:21.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.101626 27074 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/master-0/wal/instance
18:50:21.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.111728 27217 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: Bootstrap starting.
18:50:21.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.115314 27217 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: Neither blocks nor log segments found. Creating new log.
18:50:21.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.116703 27217 log.cc:824] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: Log is configured to *not* fsync() on all Append() calls
18:50:21.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.119656 27217 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: No bootstrap required, opened a new log
18:50:21.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.127252 27217 raft_consensus.cc:348] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } }
18:50:21.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.127782 27217 raft_consensus.cc:374] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:50:21.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.127880 27217 raft_consensus.cc:729] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bf0836d673f449d6a71048c4d4723cc4, State: Initialized, Role: FOLLOWER
18:50:21.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:21 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.112.190@KRBTEST.COM
18:50:21.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.128552 27217 consensus_queue.cc:260] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [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: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } }
18:50:21.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.128756 27217 raft_consensus.cc:388] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
18:50:21.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.128852 27217 raft_consensus.cc:482] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
18:50:21.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.128978 27217 raft_consensus.cc:3037] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 0 FOLLOWER]: Advancing to term 1
18:50:21.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.131961 27217 raft_consensus.cc:504] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } }
18:50:21.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.132613 27217 leader_election.cc:302] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [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: bf0836d673f449d6a71048c4d4723cc4; no voters: 
18:50:21.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.133934 27217 leader_election.cc:288] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [CANDIDATE]: Term 1 election: Requested vote from peers 
18:50:21.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.134150 27224 raft_consensus.cc:2781] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 1 FOLLOWER]: Leader election won for term 1
18:50:21.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.134912 27224 raft_consensus.cc:686] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [term 1 LEADER]: Becoming Leader. State: Replica: bf0836d673f449d6a71048c4d4723cc4, State: Running, Role: LEADER
18:50:21.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.135838 27224 consensus_queue.cc:237] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [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: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } }
18:50:21.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.138720 27217 sys_catalog.cc:564] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [sys.catalog]: configured and running, proceeding with master startup.
18:50:21.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.139215 27225 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader bf0836d673f449d6a71048c4d4723cc4. Latest consensus state: current_term: 1 leader_uuid: "bf0836d673f449d6a71048c4d4723cc4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } } }
18:50:21.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.139562 27225 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [sys.catalog]: This master's current role is: LEADER
18:50:21.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.140552 27229 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
18:50:21.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.141711 27227 sys_catalog.cc:455] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "bf0836d673f449d6a71048c4d4723cc4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "bf0836d673f449d6a71048c4d4723cc4" member_type: VOTER last_known_addr { host: "127.26.112.190" port: 44687 } } }
18:50:21.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.142050 27227 sys_catalog.cc:458] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4 [sys.catalog]: This master's current role is: LEADER
18:50:21.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.154304 27229 catalog_manager.cc:1484] Initializing Kudu cluster ID...
18:50:21.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.166467 27229 catalog_manager.cc:1347] Generated new cluster ID: 842040830e444595973b90e8b8a9bb21
18:50:21.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.166605 27229 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
18:50:21.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.196424 27229 catalog_manager.cc:1370] Generated new certificate authority record
18:50:21.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.198140 27229 catalog_manager.cc:1504] Loading token signing keys...
18:50:21.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.208122 27229 catalog_manager.cc:5868] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: Generated new TSK 0
18:50:21.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.209333 27229 catalog_manager.cc:1514] Initializing in-progress tserver states...
18:50:21.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.112.129@KRBTEST.COM; defaulting to no policy
18:50:21.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:21.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.112.129@KRBTEST.COM" created.
18:50:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.129 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.129.keytab.
18:50:21.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.129 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.129.keytab.
18:50:21.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.286650 27074 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/logs
18:50:21.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data/info.pb
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:21.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.129:0
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.129
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.129
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.129.keytab
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.129
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:50:21.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:21.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:21.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:21.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:21.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:21.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:50:21.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.655014 27253 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:50:21.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.656203 27253 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:50:21.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.656352 27253 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:50:21.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.656474 27253 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:50:21.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.670380 27253 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:50:21.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.670675 27253 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.112.129
18:50:21.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.685292 27253 tablet_server_runner.cc:78] Tablet server non-default flags:
18:50:21.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:21.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.129.keytab
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.129
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.129:0
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data/info.pb
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.129
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:21.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.129
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/logs
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 16:09:54 UTC on ccycloud.quasar-hitlqc.root.comops.site
18:50:21.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580676
18:50:21.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
18:50:21.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.686808 27253 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:50:21.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.688386 27253 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:50:21.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.702376 27259 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:50:21.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.702299 27263 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:50:21.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:21.702332 27260 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:50:21.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.703770 27253 server_base.cc:1034] running on GCE node
18:50:21.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.704605 27253 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:50:21.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.705919 27253 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:50:21.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.707583 27253 hybrid_clock.cc:648] HybridClock initialized: now 1786474221707503 us; error 46 us; skew 500 ppm
18:50:21.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.707988 27253 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:50:21.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:21 dist-test-slave-gkw7 krb5kdc[27088](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474221, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.129@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:50:21.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.712540 27253 init.cc:377] Logged in from keytab as kudu/127.26.112.129@KRBTEST.COM (short username kudu)
18:50:21.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.714498 27253 webserver.cc:460] Webserver started at http://127.26.112.129:35211/ using document root <none> and password file <none>
18:50:21.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.715291 27253 fs_manager.cc:359] Metadata directory not provided
18:50:21.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.715407 27253 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:50:21.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.715703 27253 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.718647 27253 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data/instance:
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f61f31ae6ce4c0daae7274494b8e54e"
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.719450 27253 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal/instance:
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f61f31ae6ce4c0daae7274494b8e54e"
18:50:21.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.725730 27253 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.000s
18:50:21.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.729651 27276 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:50:21.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.731137 27253 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
18:50:21.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.731451 27253 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data,/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal
18:50:21.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "7f61f31ae6ce4c0daae7274494b8e54e"
18:50:21.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:21 on dist-test-slave-gkw7"
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.731711 27253 fs_report.cc:383] FS layout report
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data/data
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:50:21.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:50:21.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:50:21.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:50:21.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:50:21.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:50:21.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:50:21.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.744401 27253 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:50:21.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.749599 27253 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:50:21.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.750020 27253 kserver.cc:163] Server-wide thread pool size limit: 3276
18:50:21.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.751374 27253 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:50:21.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.752966 27253 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:50:21.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.753074 27253 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:50:21.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.753242 27253 ts_tablet_manager.cc:610] Registered 0 tablets
18:50:21.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.753310 27253 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:50:21.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.791018 27253 rpc_server.cc:307] RPC server started. Bound to: 127.26.112.129:34243
18:50:21.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.791069 27446 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.112.129:34243 every 8 connection(s)
18:50:21.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.792495 27253 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/data/info.pb
18:50:21.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.801262 27074 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskYhykuz/build/asan/bin/kudu as pid 27253
18:50:21.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.801497 27074 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal/instance
18:50:21.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:21 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474221, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.129@KRBTEST.COM for kudu/127.26.112.190@KRBTEST.COM
18:50:21.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.819057 27447 heartbeater.cc:347] Connected to a master server at 127.26.112.190:44687
18:50:21.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.819476 27447 heartbeater.cc:464] Registering TS with master...
18:50:21.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.820474 27447 heartbeater.cc:511] Master 127.26.112.190:44687 requested a full tablet report, sending...
18:50:21.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.823280 27161 ts_manager.cc:194] Registered new tserver with Master: 7f61f31ae6ce4c0daae7274494b8e54e (127.26.112.129:34243)
18:50:21.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.112.130@KRBTEST.COM; defaulting to no policy
18:50:21.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.825363 27161 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.112.129@KRBTEST.COM'} at 127.26.112.129:52187
18:50:21.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:21.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.112.130@KRBTEST.COM" created.
18:50:21.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:21.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.130 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.130.keytab.
18:50:21.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.130 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.130.keytab.
18:50:21.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:21.853610 27074 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:21.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:21.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/logs
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data/info.pb
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.130:0
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.130
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.130
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.130.keytab
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.130
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:21.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:21.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:50:22.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.200934 27453 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:50:22.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.201303 27453 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:50:22.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.201390 27453 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:50:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.201495 27453 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:50:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.209333 27453 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:50:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.209604 27453 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.112.130
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.219688 27453 tablet_server_runner.cc:78] Tablet server non-default flags:
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.130.keytab
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.130
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.130:0
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:22.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data/info.pb
18:50:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.130
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.130
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/logs
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:50:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 16:09:54 UTC on ccycloud.quasar-hitlqc.root.comops.site
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580676
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.221547 27453 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:50:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.223536 27453 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:50:22.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.237932 27465 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:50:22.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.237887 27467 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:50:22.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.237852 27470 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:50:22.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.238724 27453 server_base.cc:1034] running on GCE node
18:50:22.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.239444 27453 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:50:22.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.240638 27453 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:50:22.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.242089 27453 hybrid_clock.cc:648] HybridClock initialized: now 1786474222241973 us; error 101 us; skew 500 ppm
18:50:22.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.242434 27453 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:50:22.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:22 dist-test-slave-gkw7 krb5kdc[27088](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474222, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.130@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:50:22.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.245941 27453 init.cc:377] Logged in from keytab as kudu/127.26.112.130@KRBTEST.COM (short username kudu)
18:50:22.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.247781 27453 webserver.cc:460] Webserver started at http://127.26.112.130:33013/ using document root <none> and password file <none>
18:50:22.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.248624 27453 fs_manager.cc:359] Metadata directory not provided
18:50:22.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.248801 27453 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:50:22.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.249197 27453 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.252627 27453 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data/instance:
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a6adbe0f2cb48658c4ffba24d4e251e"
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.253334 27453 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal/instance:
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a6adbe0f2cb48658c4ffba24d4e251e"
18:50:22.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.260430 27453 fs_manager.cc:691] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.001s
18:50:22.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.264547 27478 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.266265 27453 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.266434 27453 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data,/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "8a6adbe0f2cb48658c4ffba24d4e251e"
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.266628 27453 fs_report.cc:383] FS layout report
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data/data
18:50:22.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:50:22.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:50:22.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.280993 27453 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:50:22.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.285683 27453 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:50:22.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.285964 27453 kserver.cc:163] Server-wide thread pool size limit: 3276
18:50:22.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.287002 27453 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:50:22.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.288391 27453 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:50:22.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.288465 27453 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:50:22.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.288609 27453 ts_tablet_manager.cc:610] Registered 0 tablets
18:50:22.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.288671 27453 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:50:22.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.323340 27453 rpc_server.cc:307] RPC server started. Bound to: 127.26.112.130:35585
18:50:22.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.323391 27635 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.112.130:35585 every 8 connection(s)
18:50:22.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.324597 27453 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/data/info.pb
18:50:22.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.324870 27074 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskYhykuz/build/asan/bin/kudu as pid 27453
18:50:22.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.325021 27074 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal/instance
18:50:22.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:22 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474222, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.130@KRBTEST.COM for kudu/127.26.112.190@KRBTEST.COM
18:50:22.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.26.112.131@KRBTEST.COM; defaulting to no policy
18:50:22.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:22.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.26.112.131@KRBTEST.COM" created.
18:50:22.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.356351 27636 heartbeater.cc:347] Connected to a master server at 127.26.112.190:44687
18:50:22.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.356739 27636 heartbeater.cc:464] Registering TS with master...
18:50:22.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.357717 27636 heartbeater.cc:511] Master 127.26.112.190:44687 requested a full tablet report, sending...
18:50:22.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.359591 27161 ts_manager.cc:194] Registered new tserver with Master: 8a6adbe0f2cb48658c4ffba24d4e251e (127.26.112.130:35585)
18:50:22.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.360632 27161 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.112.130@KRBTEST.COM'} at 127.26.112.130:37897
18:50:22.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:50:22.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.131 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.131.keytab.
18:50:22.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.26.112.131 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.131.keytab.
18:50:22.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.379436 27074 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:22.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskYhykuz/build/asan/bin/kudu
18:50:22.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/logs
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data/info.pb
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:22.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.131:0
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.131
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.131
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.131.keytab
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.131
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:22.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:22.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:22.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:50:22.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.724802 27647 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:50:22.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.725136 27647 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:50:22.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.725196 27647 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:50:22.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.725277 27647 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:50:22.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.732676 27647 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:50:22.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.732848 27647 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.26.112.131
18:50:22.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.743276 27647 tablet_server_runner.cc:78] Tablet server non-default flags:
18:50:22.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:50:22.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.26.112.148:33375
18:50:22.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kudu_127.26.112.131.keytab
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.26.112.131
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.26.112.131:0
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data/info.pb
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.26.112.131
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.26.112.190:44687
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.26.112.131
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/logs
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 16:09:54 UTC on ccycloud.quasar-hitlqc.root.comops.site
18:50:22.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580676
18:50:22.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
18:50:22.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.745019 27647 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:50:22.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.746409 27647 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:50:22.760 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.760618 27656 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:50:22.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.760630 27657 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:50:22.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:22.760846 27660 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:50:22.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.761865 27647 server_base.cc:1034] running on GCE node
18:50:22.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.762513 27647 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:50:22.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.763522 27647 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:50:22.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.764808 27647 hybrid_clock.cc:648] HybridClock initialized: now 1786474222764731 us; error 56 us; skew 500 ppm
18:50:22.765 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.765240 27647 server_base.cc:834] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
18:50:22.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:22 dist-test-slave-gkw7 krb5kdc[27088](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474222, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.131@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:50:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.769122 27647 init.cc:377] Logged in from keytab as kudu/127.26.112.131@KRBTEST.COM (short username kudu)
18:50:22.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.771015 27647 webserver.cc:460] Webserver started at http://127.26.112.131:35155/ using document root <none> and password file <none>
18:50:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.771837 27647 fs_manager.cc:359] Metadata directory not provided
18:50:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.772001 27647 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:50:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.772383 27647 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.775507 27647 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data/instance:
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c120031a0e2d41c0a1ed4be4645c0009"
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.776562 27647 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal/instance:
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c120031a0e2d41c0a1ed4be4645c0009"
18:50:22.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.783058 27647 fs_manager.cc:691] Time spent creating directory manager: real 0.006s	user 0.007s	sys 0.001s
18:50:22.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.787519 27673 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:50:22.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.789157 27647 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
18:50:22.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.789412 27647 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data,/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal
18:50:22.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c120031a0e2d41c0a1ed4be4645c0009"
18:50:22.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:50:22 on dist-test-slave-gkw7"
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.789767 27647 fs_report.cc:383] FS layout report
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data/data
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:50:22.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:50:22.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.805348 27647 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:50:22.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.810822 27647 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:50:22.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.811249 27647 kserver.cc:163] Server-wide thread pool size limit: 3276
18:50:22.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.812487 27647 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:50:22.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.814150 27647 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:50:22.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.814280 27647 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:50:22.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.814440 27647 ts_tablet_manager.cc:610] Registered 0 tablets
18:50:22.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.814510 27647 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:50:22.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.829599 27447 heartbeater.cc:503] Master 127.26.112.190:44687 was elected leader, sending a full tablet report...
18:50:22.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.853366 27647 rpc_server.cc:307] RPC server started. Bound to: 127.26.112.131:32811
18:50:22.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.853411 27841 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.26.112.131:32811 every 8 connection(s)
18:50:22.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.854777 27647 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/data/info.pb
18:50:22.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.861622 27074 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskYhykuz/build/asan/bin/kudu as pid 27647
18:50:22.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.861871 27074 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal/instance
18:50:22.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:22 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474222, etypes {rep=17 tkt=17 ses=17}, kudu/127.26.112.131@KRBTEST.COM for kudu/127.26.112.190@KRBTEST.COM
18:50:22.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.878648 27843 heartbeater.cc:347] Connected to a master server at 127.26.112.190:44687
18:50:22.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.878961 27843 heartbeater.cc:464] Registering TS with master...
18:50:22.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.879701 27843 heartbeater.cc:511] Master 127.26.112.190:44687 requested a full tablet report, sending...
18:50:22.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.881199 27161 ts_manager.cc:194] Registered new tserver with Master: c120031a0e2d41c0a1ed4be4645c0009 (127.26.112.131:32811)
18:50:22.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.882158 27161 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.26.112.131@KRBTEST.COM'} at 127.26.112.131:57369
18:50:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:22.891322 27074 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
18:50:22.893 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:50:22.895 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

18:50:22.906 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

18:50:22.907 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:50:22.917 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.112.190"
      port: 44687
    }
    bound_http_address {
      host: "127.26.112.190"
      port: 44593
    }
  }
}

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

18:50:22.924 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.26.112.129"
      port: 34243
    }
    bound_http_address {
      host: "127.26.112.129"
      port: 35211
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.26.112.130"
      port: 35585
    }
    bound_http_address {
      host: "127.26.112.130"
      port: 33013
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.26.112.131"
      port: 32811
    }
    bound_http_address {
      host: "127.26.112.131"
      port: 35155
    }
  }
}

18:50:22.925 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:50:23.113 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/krb5kdc/krb5cc
18:50:23.134 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
18:50:23.311 [DEBUG - main] (Connection.java:748) [peer master-127.26.112.190:44687(127.26.112.190:44687)] connecting to peer
18:50:23.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:23.363463 27636 heartbeater.cc:503] Master 127.26.112.190:44687 was elected leader, sending a full tablet report...
18:50:23.396 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.26.112.190:44687(127.26.112.190:44687)] Successfully connected to peer
18:50:23.489 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.26.112.190
18:50:23.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:23 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.112.190@KRBTEST.COM
18:50:23.736 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x5f0a6556, L:/127.0.0.1:46348 - R:/127.26.112.190:44687] using SASL/GSSAPI
18:50:23.778 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:50:23.779 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=515), Traces: [0ms] refreshing cache from master, [33ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.112.190:44687, [482ms] Sub RPC ConnectToMaster: received response from server master-127.26.112.190:44687: OK, deferred=null) after lookup
18:50:23.801 [DEBUG - main] (Connection.java:575) [peer master-127.26.112.190:44687(127.26.112.190:44687)] disconnecting while in state READY
18:50:23.808 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.26.112.190:44687(127.26.112.190:44687)] handling channelInactive
18:50:23.808 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.26.112.190:44687(127.26.112.190:44687)] cleaning up while in state READY due to: connection closed
18:50:23.809 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.26.112.190:44687(127.26.112.190:44687) for tablet Kudu Master: connection closed
18:50:23.826 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.26.112.190:44687(127.26.112.190:44687)] connecting to peer
18:50:23.830 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.26.112.190:44687(127.26.112.190:44687)] Successfully connected to peer
18:50:23.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:23.884923 27843 heartbeater.cc:503] Master 127.26.112.190:44687 was elected leader, sending a full tablet report...
18:50:23.894 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x418c9477, L:/127.0.0.1:46354 - R:/127.26.112.190:44687] using TOKEN/null
18:50:23.898 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:50:23.899 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=96), Traces: [0ms] sending RPC to server master-127.26.112.190:44687, [6ms] received response from server master-127.26.112.190:44687: Network error: connection closed, [6ms] delaying RPC due to: Network error: connection closed, [21ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.26.112.190:44687, [94ms] Sub RPC ConnectToMaster: received response from server master-127.26.112.190:44687: OK, deferred=Deferred@1394922763(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:23.969050 27161 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:46354:
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:50:23.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:50:23.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:50:23.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:50:23.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:23.977085 27161 catalog_manager.cc:6854] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table TestAuthnTokenReacquireOpen-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:50:24.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.027992 27545 tablet_service.cc:1467] Processing CreateTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]), partition=RANGE (key) PARTITION UNBOUNDED
18:50:24.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.030184 27545 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 523ca54d5fd446eeb8c27a619fe4a574. 1 dirs total, 0 dirs full, 0 dirs failed
18:50:24.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.031888 27745 tablet_service.cc:1467] Processing CreateTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]), partition=RANGE (key) PARTITION UNBOUNDED
18:50:24.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.032739 27349 tablet_service.cc:1467] Processing CreateTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]), partition=RANGE (key) PARTITION UNBOUNDED
18:50:24.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.033681 27745 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 523ca54d5fd446eeb8c27a619fe4a574. 1 dirs total, 0 dirs full, 0 dirs failed
18:50:24.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.034350 27349 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 523ca54d5fd446eeb8c27a619fe4a574. 1 dirs total, 0 dirs full, 0 dirs failed
18:50:24.038 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 41dab6a3f6244688a92f2b2887cf4269
18:50:24.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.048426 27875 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Bootstrap starting.
18:50:24.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.050558 27877 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Bootstrap starting.
18:50:24.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.052253 27876 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Bootstrap starting.
18:50:24.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.053445 27875 tablet_bootstrap.cc:654] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Neither blocks nor log segments found. Creating new log.
18:50:24.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.054631 27877 tablet_bootstrap.cc:654] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Neither blocks nor log segments found. Creating new log.
18:50:24.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.055750 27875 log.cc:824] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Log is configured to *not* fsync() on all Append() calls
18:50:24.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.055804 27877 log.cc:824] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Log is configured to *not* fsync() on all Append() calls
18:50:24.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.056705 27876 tablet_bootstrap.cc:654] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Neither blocks nor log segments found. Creating new log.
18:50:24.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.058156 27876 log.cc:824] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Log is configured to *not* fsync() on all Append() calls
18:50:24.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.059522 27875 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: No bootstrap required, opened a new log
18:50:24.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.059842 27877 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: No bootstrap required, opened a new log
18:50:24.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.060143 27877 ts_tablet_manager.cc:1397] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Time spent bootstrapping tablet: real 0.010s	user 0.008s	sys 0.000s
18:50:24.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.060885 27875 ts_tablet_manager.cc:1397] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Time spent bootstrapping tablet: real 0.013s	user 0.006s	sys 0.004s
18:50:24.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.061401 27876 tablet_bootstrap.cc:492] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: No bootstrap required, opened a new log
18:50:24.062 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.061956 27876 ts_tablet_manager.cc:1397] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Time spent bootstrapping tablet: real 0.010s	user 0.009s	sys 0.000s
18:50:24.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.071765 27877 raft_consensus.cc:348] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.072194 27875 raft_consensus.cc:348] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.072628 27877 raft_consensus.cc:374] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:50:24.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.072762 27877 raft_consensus.cc:729] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 7f61f31ae6ce4c0daae7274494b8e54e, State: Initialized, Role: FOLLOWER
18:50:24.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.073033 27875 raft_consensus.cc:374] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:50:24.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.073323 27875 raft_consensus.cc:729] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 8a6adbe0f2cb48658c4ffba24d4e251e, State: Initialized, Role: FOLLOWER
18:50:24.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.073342 27876 raft_consensus.cc:348] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.073689 27877 consensus_queue.cc:260] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [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: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.074064 27876 raft_consensus.cc:374] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:50:24.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.074180 27876 raft_consensus.cc:729] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c120031a0e2d41c0a1ed4be4645c0009, State: Initialized, Role: FOLLOWER
18:50:24.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.074163 27875 consensus_queue.cc:260] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [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: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.074936 27876 consensus_queue.cc:260] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [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: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.083779 27877 ts_tablet_manager.cc:1428] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Time spent starting tablet: real 0.024s	user 0.023s	sys 0.000s
18:50:24.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.083914 27876 ts_tablet_manager.cc:1428] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Time spent starting tablet: real 0.022s	user 0.015s	sys 0.004s
18:50:24.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.085951 27875 ts_tablet_manager.cc:1428] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Time spent starting tablet: real 0.025s	user 0.019s	sys 0.004s
18:50:24.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.093158 27886 raft_consensus.cc:482] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:50:24.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.093837 27886 raft_consensus.cc:504] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.095953 27886 leader_election.cc:288] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 8a6adbe0f2cb48658c4ffba24d4e251e (127.26.112.130:35585), 7f61f31ae6ce4c0daae7274494b8e54e (127.26.112.129:34243)
18:50:24.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.105968 27572 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "523ca54d5fd446eeb8c27a619fe4a574" candidate_uuid: "c120031a0e2d41c0a1ed4be4645c0009" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" is_pre_election: true
18:50:24.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.106616 27572 raft_consensus.cc:2454] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate c120031a0e2d41c0a1ed4be4645c0009 in term 0.
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.107381 27675 leader_election.cc:302] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [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: 8a6adbe0f2cb48658c4ffba24d4e251e, c120031a0e2d41c0a1ed4be4645c0009; no voters: 
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:24.107663 27844 tablet.cc:2369] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.107977 27886 raft_consensus.cc:2781] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.108127 27886 raft_consensus.cc:482] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.108227 27886 raft_consensus.cc:3037] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 0 FOLLOWER]: Advancing to term 1
18:50:24.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.108421 27380 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "523ca54d5fd446eeb8c27a619fe4a574" candidate_uuid: "c120031a0e2d41c0a1ed4be4645c0009" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" is_pre_election: true
18:50:24.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.108973 27380 raft_consensus.cc:2454] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate c120031a0e2d41c0a1ed4be4645c0009 in term 0.
18:50:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.111236 27886 raft_consensus.cc:504] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.112006 27886 leader_election.cc:288] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [CANDIDATE]: Term 1 election: Requested vote from peers 8a6adbe0f2cb48658c4ffba24d4e251e (127.26.112.130:35585), 7f61f31ae6ce4c0daae7274494b8e54e (127.26.112.129:34243)
18:50:24.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.112584 27572 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "523ca54d5fd446eeb8c27a619fe4a574" candidate_uuid: "c120031a0e2d41c0a1ed4be4645c0009" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e"
18:50:24.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.112870 27572 raft_consensus.cc:3037] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 0 FOLLOWER]: Advancing to term 1
18:50:24.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.112877 27380 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "523ca54d5fd446eeb8c27a619fe4a574" candidate_uuid: "c120031a0e2d41c0a1ed4be4645c0009" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "7f61f31ae6ce4c0daae7274494b8e54e"
18:50:24.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.113106 27380 raft_consensus.cc:3037] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 0 FOLLOWER]: Advancing to term 1
18:50:24.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.115197 27572 raft_consensus.cc:2454] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate c120031a0e2d41c0a1ed4be4645c0009 in term 1.
18:50:24.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.115691 27675 leader_election.cc:302] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [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: 8a6adbe0f2cb48658c4ffba24d4e251e, c120031a0e2d41c0a1ed4be4645c0009; no voters: 
18:50:24.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.116043 27886 raft_consensus.cc:2781] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 1 FOLLOWER]: Leader election won for term 1
18:50:24.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.116468 27380 raft_consensus.cc:2454] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate c120031a0e2d41c0a1ed4be4645c0009 in term 1.
18:50:24.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.116618 27886 raft_consensus.cc:686] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 1 LEADER]: Becoming Leader. State: Replica: c120031a0e2d41c0a1ed4be4645c0009, State: Running, Role: LEADER
18:50:24.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.117273 27886 consensus_queue.cc:237] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [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: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } }
18:50:24.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.122675 27155 catalog_manager.cc:5495] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 reported cstate change: term changed from 0 to 1, leader changed from <none> to c120031a0e2d41c0a1ed4be4645c0009 (127.26.112.131). New cstate: current_term: 1 leader_uuid: "c120031a0e2d41c0a1ed4be4645c0009" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "c120031a0e2d41c0a1ed4be4645c0009" member_type: VOTER last_known_addr { host: "127.26.112.131" port: 32811 } health_report { overall_health: HEALTHY } } }
18:50:24.132 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 41dab6a3f6244688a92f2b2887cf4269
18:50:24.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:24.296674 27448 tablet.cc:2369] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:50:24.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:24.333849 27638 tablet.cc:2369] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:50:24.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.599371 27886 consensus_queue.cc:1035] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [LEADER]: Connected to new peer: Peer: permanent_uuid: "8a6adbe0f2cb48658c4ffba24d4e251e" member_type: VOTER last_known_addr { host: "127.26.112.130" port: 35585 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:50:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:24.610189 27899 consensus_queue.cc:1035] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [LEADER]: Connected to new peer: Peer: permanent_uuid: "7f61f31ae6ce4c0daae7274494b8e54e" member_type: VOTER last_known_addr { host: "127.26.112.129" port: 34243 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:50:25.137 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 41dab6a3f6244688a92f2b2887cf4269
18:50:25.165 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 523ca54d5fd446eeb8c27a619fe4a574 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
18:50:25.173 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299992, tablet=523ca54d5fd446eeb8c27a619fe4a574@[7f61f31ae6ce4c0daae7274494b8e54e(127.26.112.129:34243),8a6adbe0f2cb48658c4ffba24d4e251e(127.26.112.130:35585),c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)[L]]}]
18:50:25.174 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC ScanRequest(scannerId=null, state=OPENING, attempt=1, KuduRpc(method=Scan, tablet=null, attempt=1, TimeoutTracker(timeout=60000, elapsed=21), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.26.112.190:44687, [11ms] Sub RPC GetTableLocations: received response from server master-127.26.112.190:44687: OK, deferred=null)) after lookup
18:50:25.186 [DEBUG - kudu-nio-1] (Connection.java:748) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] connecting to peer
18:50:25.188 [DEBUG - kudu-nio-0] (Connection.java:757) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] Successfully connected to peer
18:50:25.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:25.209909 27906 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:58790: token expired
18:50:25.214 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.26.112.131:32811 sent connection negotiation error: Not authorized: token expired
18:50:25.215 [DEBUG - kudu-nio-0] (Connection.java:239) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] handling channelInactive
18:50:25.216 [DEBUG - kudu-nio-0] (Connection.java:709) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
18:50:25.219 [DEBUG - kudu-nio-0] (Connection.java:748) [peer master-127.26.112.190:44687(127.26.112.190:44687)] connecting to peer
18:50:25.221 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.26.112.190:44687(127.26.112.190:44687)] Successfully connected to peer
18:50:25.224 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.26.112.190
18:50:25.254 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x53a47c9f, L:/127.0.0.1:46364 - R:/127.26.112.190:44687] using SASL/GSSAPI
18:50:25.257 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
18:50:25.259 [DEBUG - kudu-nio-1] (Connection.java:748) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] connecting to peer
18:50:25.260 [DEBUG - kudu-nio-0] (Connection.java:757) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] Successfully connected to peer
18:50:25.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:25.281456 27906 fault_injection.cc:43] FAULT INJECTION ENABLED!
18:50:25.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:25.281635 27906 fault_injection.cc:44] THIS SERVER MAY CRASH!
18:50:25.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:50:25.282127 27906 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:58792: token signing key expired
18:50:25.282 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.26.112.131:32811 sent connection negotiation error: Not authorized: token signing key expired
18:50:25.283 [DEBUG - kudu-nio-0] (Connection.java:239) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] handling channelInactive
18:50:25.283 [DEBUG - kudu-nio-0] (Connection.java:709) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
18:50:25.287 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
18:50:25.288 [DEBUG - kudu-nio-1] (Connection.java:748) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] connecting to peer
18:50:25.289 [DEBUG - kudu-nio-1] (Connection.java:757) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] Successfully connected to peer
18:50:25.312 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xb9987895, L:/127.0.0.1:58806 - R:/127.26.112.131:32811] using TOKEN/null
18:50:25.339 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=523ca54d5fd446eeb8c27a619fe4a574, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:50:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.352509 27156 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:46364:
18:50:25.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
18:50:25.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.352867 27156 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:46364:
18:50:25.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
18:50:25.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.358953 27156 catalog_manager.cc:5782] T 00000000000000000000000000000000 P bf0836d673f449d6a71048c4d4723cc4: Sending DeleteTablet for 3 replicas of tablet 523ca54d5fd446eeb8c27a619fe4a574
18:50:25.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.360656 27545 tablet_service.cc:1514] Processing DeleteTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:50:25 UTC) from {username='kudu', principal='kudu/127.26.112.190@KRBTEST.COM'} at 127.0.0.1:43052
18:50:25.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.360874 27349 tablet_service.cc:1514] Processing DeleteTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:50:25 UTC) from {username='kudu', principal='kudu/127.26.112.190@KRBTEST.COM'} at 127.0.0.1:40754
18:50:25.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.361352 27745 tablet_service.cc:1514] Processing DeleteTablet for tablet 523ca54d5fd446eeb8c27a619fe4a574 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:50:25 UTC) from {username='kudu', principal='kudu/127.26.112.190@KRBTEST.COM'} at 127.0.0.1:58778
18:50:25.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.362200 27916 tablet_replica.cc:330] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: stopping tablet replica
18:50:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.362848 27916 raft_consensus.cc:2229] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 1 FOLLOWER]: Raft consensus shutting down.
18:50:25.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.363436 27916 raft_consensus.cc:2258] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e [term 1 FOLLOWER]: Raft consensus is shut down!
18:50:25.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.365478 27916 ts_tablet_manager.cc:1905] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Deleting tablet data with delete state TABLET_DATA_DELETED
18:50:25.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.369253 27920 tablet_replica.cc:330] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: stopping tablet replica
18:50:25.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.369939 27920 raft_consensus.cc:2229] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 1 LEADER]: Raft consensus shutting down.
18:50:25.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.370026 27918 tablet_replica.cc:330] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: stopping tablet replica
18:50:25.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.370538 27918 raft_consensus.cc:2229] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 1 FOLLOWER]: Raft consensus shutting down.
18:50:25.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.371011 27918 raft_consensus.cc:2258] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e [term 1 FOLLOWER]: Raft consensus is shut down!
18:50:25.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.371342 27920 raft_consensus.cc:2258] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009 [term 1 FOLLOWER]: Raft consensus is shut down!
18:50:25.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.373544 27920 ts_tablet_manager.cc:1905] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Deleting tablet data with delete state TABLET_DATA_DELETED
18:50:25.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.374634 27916 ts_tablet_manager.cc:1918] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:50:25.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.374825 27916 log.cc:1196] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Deleting WAL directory at /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-1/wal/wals/523ca54d5fd446eeb8c27a619fe4a574
18:50:25.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.375365 27916 ts_tablet_manager.cc:1939] T 523ca54d5fd446eeb8c27a619fe4a574 P 8a6adbe0f2cb48658c4ffba24d4e251e: Deleting consensus metadata
18:50:25.376 [DEBUG - main] (Connection.java:575) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] disconnecting while in state READY
18:50:25.377 [DEBUG - main] (Connection.java:575) [peer master-127.26.112.190:44687(127.26.112.190:44687)] disconnecting while in state READY
18:50:25.378 [DEBUG - main] (Connection.java:575) [peer master-127.26.112.190:44687(127.26.112.190:44687)] disconnecting while in state READY
18:50:25.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.377480 27131 catalog_manager.cc:4841] TS 8a6adbe0f2cb48658c4ffba24d4e251e (127.26.112.130:35585): tablet 523ca54d5fd446eeb8c27a619fe4a574 (table TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]) successfully deleted
18:50:25.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.379603 27918 ts_tablet_manager.cc:1905] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Deleting tablet data with delete state TABLET_DATA_DELETED
18:50:25.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.386544 27918 ts_tablet_manager.cc:1918] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:50:25.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.387233 27920 ts_tablet_manager.cc:1918] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:50:25.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.387439 27918 log.cc:1196] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Deleting WAL directory at /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-0/wal/wals/523ca54d5fd446eeb8c27a619fe4a574
18:50:25.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.387629 27920 log.cc:1196] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Deleting WAL directory at /tmp/dist-test-taskYhykuz/test-tmp/mini-kudu-cluster2019260576853747932/ts-2/wal/wals/523ca54d5fd446eeb8c27a619fe4a574
18:50:25.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.388218 27918 ts_tablet_manager.cc:1939] T 523ca54d5fd446eeb8c27a619fe4a574 P 7f61f31ae6ce4c0daae7274494b8e54e: Deleting consensus metadata
18:50:25.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.388345 27920 ts_tablet_manager.cc:1939] T 523ca54d5fd446eeb8c27a619fe4a574 P c120031a0e2d41c0a1ed4be4645c0009: Deleting consensus metadata
18:50:25.390 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:50:25.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.390498 27131 catalog_manager.cc:4841] TS 7f61f31ae6ce4c0daae7274494b8e54e (127.26.112.129:34243): tablet 523ca54d5fd446eeb8c27a619fe4a574 (table TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]) successfully deleted
18:50:25.391 [DEBUG - kudu-nio-1] (Connection.java:239) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] handling channelInactive
18:50:25.391 [DEBUG - kudu-nio-1] (Connection.java:709) [peer c120031a0e2d41c0a1ed4be4645c0009(127.26.112.131:32811)] cleaning up while in state READY due to: connection closed
18:50:25.392 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.26.112.190:44687(127.26.112.190:44687)] handling channelInactive
18:50:25.392 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.26.112.190:44687(127.26.112.190:44687)] cleaning up while in state READY due to: connection closed
18:50:25.392 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.26.112.190:44687(127.26.112.190:44687)] handling channelInactive
18:50:25.392 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.26.112.190:44687(127.26.112.190:44687)] cleaning up while in state READY due to: connection closed
18:50:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.392040 27135 catalog_manager.cc:4841] TS c120031a0e2d41c0a1ed4be4645c0009 (127.26.112.131:32811): tablet 523ca54d5fd446eeb8c27a619fe4a574 (table TestAuthnTokenReacquireOpen-table [id=41dab6a3f6244688a92f2b2887cf4269]) successfully deleted
18:50:25.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.392639 27074 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskYhykuz/build/asan/bin/kudu pid 27253
18:50:25.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:25 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.112.129@KRBTEST.COM
18:50:25.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.420895 27440 generic_service.cc:196] Checking for leaks (request via RPC)
18:50:25.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.541378 27074 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskYhykuz/build/asan/bin/kudu with pid 27253
18:50:25.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.575577 27074 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskYhykuz/build/asan/bin/kudu pid 27453
18:50:25.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:25 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.112.130@KRBTEST.COM
18:50:25.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.594445 27631 generic_service.cc:196] Checking for leaks (request via RPC)
18:50:25.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.702891 27074 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskYhykuz/build/asan/bin/kudu with pid 27453
18:50:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.724694 27074 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskYhykuz/build/asan/bin/kudu pid 27647
18:50:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:50:25 dist-test-slave-gkw7 krb5kdc[27088](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474220, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.26.112.131@KRBTEST.COM
18:50:25.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.742643 27834 generic_service.cc:196] Checking for leaks (request via RPC)
18:50:25.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.873757 27074 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskYhykuz/build/asan/bin/kudu with pid 27647
18:50:25.899 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.898770 27074 external_mini_cluster.cc:1636] Attempting to check leaks for /tmp/dist-test-taskYhykuz/build/asan/bin/kudu pid 27108
18:50:25.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:25.900038 27210 generic_service.cc:196] Checking for leaks (request via RPC)
18:50:26.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:50:26.010520 27074 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskYhykuz/build/asan/bin/kudu with pid 27108
18:50:26.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:50:26Z chronyd exiting

Time: 8.094

OK (1 test)

