JUnit version 4.13.2
.14:17:31.685 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1779113851677
14:17:31.719 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
14:17:31.756 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
14:17:31.764 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task5KiCyo/test-tmp
14:17:31.792 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
14:17:31.795 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task5KiCyo/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
14:17:31.994 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074"
  extra_master_flags: "--webserver_require_spnego=false"
  extra_master_flags: "--authn_token_validity_seconds=1"
  extra_master_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--webserver_require_spnego=false"
  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 {
  }
}

14:17:32.010 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:17:32.013 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:17:32.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:32.015012  7865 mini_oidc.cc:150] Starting JWKS server
14:17:32.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:32.017992  7865 webserver.cc:533] Webserver started at http://127.0.0.1:44341/ using document root <none> and password file <none>
14:17:32.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:32.018236  7865 mini_oidc.cc:186] Starting OIDC Discovery server
14:17:32.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:32.018590  7865 webserver.cc:533] Webserver started at http://127.0.0.1:37141/ using document root <none> and password file <none>
14:17:32.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
14:17:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/principal' for realm 'KRBTEST.COM',
14:17:32.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
14:17:32.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:32 dist-test-slave-8dj5 krb5kdc[7876](info): setting up network...
14:17:32.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
14:17:32.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:32 dist-test-slave-8dj5 krb5kdc[7876](info): set up 2 sockets
14:17:32.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:32 dist-test-slave-8dj5 krb5kdc[7876](info): commencing operation
14:17:32.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
14:17:34.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.042831  7865 mini_kdc.cc:121] Time spent starting KDC: real 2.016s	user 0.007s	sys 0.001s
14:17:34.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
14:17:34.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:17:34.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
14:17:34.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
14:17:34.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:17:34.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
14:17:34.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
14:17:34.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:17:34.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
14:17:34.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:17:34.121 [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-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/test-user.keytab.
14:17:34.121 [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-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/test-user.keytab.
14:17:34.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:17:34.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
14:17:34.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:17:34Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
14:17:34.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:17:34Z Disabled control of system clock
14:17:34.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.174.126@KRBTEST.COM; defaulting to no policy
14:17:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.174.126@KRBTEST.COM" created.
14:17:34.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.174.126@KRBTEST.COM; defaulting to no policy
14:17:34.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.174.126@KRBTEST.COM" created.
14:17:34.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.197474  7865 external_mini_cluster.cc:1366] Running /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal
14:17:34.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data
14:17:34.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:17:34.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/logs
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data/info.pb
14:17:34.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:17:34.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:17:34.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:17:34.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.126:38337
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.126
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.126
14:17:34.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.174.126:38337
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44341/jwks.json
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:17:34.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:17:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.314600  7892 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:17:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.314865  7892 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:17:34.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.314925  7892 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:17:34.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318797  7892 flags.cc:432] Enabled experimental flag: --authn_token_validity_seconds=1
14:17:34.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318883  7892 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
14:17:34.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318912  7892 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:17:34.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318931  7892 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
14:17:34.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318949  7892 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
14:17:34.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318969  7892 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
14:17:34.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.318982  7892 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:44341/jwks.json
14:17:34.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.324508  7892 master_runner.cc:387] Master server non-default flags:
14:17:34.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data
14:17:34.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal
14:17:34.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:17:34.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:17:34.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.174.126:38337
14:17:34.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.126
14:17:34.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.126:38337
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:44341/jwks.json
14:17:34.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:34.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:17:34.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:17:34.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data/info.pb
14:17:34.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.126
14:17:34.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7892
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:17:34.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/logs
14:17:34.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:17:34.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:44 UTC on bdcb31816ec0
14:17:34.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15851
14:17:34.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.325933  7892 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:17:34.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.327081  7892 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:17:34.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.336545  7897 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
14:17:34.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.336576  7898 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
14:17:34.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.337191  7900 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
14:17:34.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.337663  7892 server_base.cc:1061] running on GCE node
14:17:34.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.338800  7892 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:17:34.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.340083  7892 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:17:34.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.341374  7892 hybrid_clock.cc:648] HybridClock initialized: now 1779113854341364 us; error 79 us; skew 500 ppm
14:17:34.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:17:34.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.345880  7892 init.cc:377] Logged in from keytab as kudu/127.7.174.126@KRBTEST.COM (short username kudu)
14:17:34.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.347198  7892 webserver.cc:533] Webserver started at http://127.7.174.126:39137/ using document root <none> and password file <none>
14:17:34.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.347971  7892 fs_manager.cc:362] Metadata directory not provided
14:17:34.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.348078  7892 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:17:34.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.348356  7892 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:17:34.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.350363  7892 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data/instance:
14:17:34.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2b284c22ac14517a51a94738c9f029f"
14:17:34.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.350996  7892 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal/instance:
14:17:34.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2b284c22ac14517a51a94738c9f029f"
14:17:34.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.356542  7892 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.005s	sys 0.000s
14:17:34.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.359759  7907 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:17:34.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.361104  7892 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
14:17:34.361 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.361294  7892 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data,/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal
14:17:34.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2b284c22ac14517a51a94738c9f029f"
14:17:34.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.361416  7892 fs_report.cc:389] FS layout report
14:17:34.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:17:34.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal
14:17:34.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal
14:17:34.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data/data
14:17:34.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:17:34.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:17:34.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:17:34.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:17:34.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:17:34.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:17:34.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.380049  7892 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:17:34.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.383363  7892 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:17:34.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.383610  7892 kserver.cc:163] Server-wide thread pool size limit: 3276
14:17:34.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.392345  7892 rpc_server.cc:307] RPC server started. Bound to: 127.7.174.126:38337
14:17:34.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.392364  7959 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.174.126:38337 every 8 connection(s)
14:17:34.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.393785  7892 server_base.cc:1193] Dumped server information to /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/data/info.pb
14:17:34.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.396905  7865 external_mini_cluster.cc:1428] Started /tmp/dist-test-task5KiCyo/build/debug/bin/kudu as pid 7892
14:17:34.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.397025  7960 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:17:34.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.397059  7865 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/master-0/wal/instance
14:17:34.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.403882  7960 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: Bootstrap starting.
14:17:34.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.407022  7960 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: Neither blocks nor log segments found. Creating new log.
14:17:34.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.408090  7960 log.cc:826] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: Log is configured to *not* fsync() on all Append() calls
14:17:34.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.411690  7960 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: No bootstrap required, opened a new log
14:17:34.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.174.126@KRBTEST.COM
14:17:34.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.415503  7960 raft_consensus.cc:359] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } }
14:17:34.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.415794  7960 raft_consensus.cc:385] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:17:34.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.415863  7960 raft_consensus.cc:740] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d2b284c22ac14517a51a94738c9f029f, State: Initialized, Role: FOLLOWER
14:17:34.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.416482  7960 consensus_queue.cc:260] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [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: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } }
14:17:34.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.416661  7960 raft_consensus.cc:399] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:17:34.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.416726  7960 raft_consensus.cc:493] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:17:34.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.416816  7960 raft_consensus.cc:3060] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 0 FOLLOWER]: Advancing to term 1
14:17:34.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.417984  7960 raft_consensus.cc:515] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } }
14:17:34.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.418421  7960 leader_election.cc:304] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [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: d2b284c22ac14517a51a94738c9f029f; no voters: 
14:17:34.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.418752  7960 leader_election.cc:290] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [CANDIDATE]: Term 1 election: Requested vote from peers 
14:17:34.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.419528  7965 raft_consensus.cc:2804] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 1 FOLLOWER]: Leader election won for term 1
14:17:34.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.419716  7965 raft_consensus.cc:697] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [term 1 LEADER]: Becoming Leader. State: Replica: d2b284c22ac14517a51a94738c9f029f, State: Running, Role: LEADER
14:17:34.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.420038  7965 consensus_queue.cc:237] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [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: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } }
14:17:34.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.420096  7960 sys_catalog.cc:565] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [sys.catalog]: configured and running, proceeding with master startup.
14:17:34.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.421412  7965 sys_catalog.cc:455] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "d2b284c22ac14517a51a94738c9f029f" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } } }
14:17:34.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.421548  7965 sys_catalog.cc:458] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [sys.catalog]: This master's current role is: LEADER
14:17:34.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.422669  7966 sys_catalog.cc:455] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [sys.catalog]: SysCatalogTable state changed. Reason: New leader d2b284c22ac14517a51a94738c9f029f. Latest consensus state: current_term: 1 leader_uuid: "d2b284c22ac14517a51a94738c9f029f" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "d2b284c22ac14517a51a94738c9f029f" member_type: VOTER last_known_addr { host: "127.7.174.126" port: 38337 } } }
14:17:34.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.422768  7966 sys_catalog.cc:458] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f [sys.catalog]: This master's current role is: LEADER
14:17:34.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.426371  7980 catalog_manager.cc:1594] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
14:17:34.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.426949  7980 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
14:17:34.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.427397  7974 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
14:17:34.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.428488  7974 catalog_manager.cc:1520] Initializing Kudu cluster ID...
14:17:34.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.435348  7974 catalog_manager.cc:1383] Generated new cluster ID: a7bbe962d423482ba979473c3c16bdd0
14:17:34.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.435441  7974 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
14:17:34.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.463575  7974 catalog_manager.cc:1406] Generated new certificate authority record
14:17:34.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.464756  7974 catalog_manager.cc:1540] Loading token signing keys...
14:17:34.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.472769  7974 catalog_manager.cc:6070] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: Generated new TSK 0
14:17:34.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.473620  7974 catalog_manager.cc:1550] Initializing in-progress tserver states...
14:17:34.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.174.65@KRBTEST.COM; defaulting to no policy
14:17:34.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.174.65@KRBTEST.COM" created.
14:17:34.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.174.65@KRBTEST.COM; defaulting to no policy
14:17:34.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.174.65@KRBTEST.COM" created.
14:17:34.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.537452  7865 external_mini_cluster.cc:1366] Running /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal
14:17:34.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data
14:17:34.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:17:34.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:17:34.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:17:34.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/logs
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data/info.pb
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:17:34.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:17:34.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.65:0
14:17:34.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.65
14:17:34.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.65
14:17:34.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.65
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:17:34.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:17:34.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:34.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:17:34.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.670190  7988 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:17:34.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.670477  7988 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:17:34.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.670506  7988 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:17:34.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.670565  7988 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:17:34.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.674944  7988 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:17:34.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.675112  7988 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.174.65
14:17:34.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.679926  7988 tablet_server_runner.cc:78] Tablet server non-default flags:
14:17:34.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.65
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.65:0
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:17:34.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data/info.pb
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.65
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7988
14:17:34.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.65
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/logs
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:17:34.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:44 UTC on bdcb31816ec0
14:17:34.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15851
14:17:34.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.681669  7988 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:17:34.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.682950  7988 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:17:34.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.693209  7993 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
14:17:34.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.693209  7996 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
14:17:34.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.693216  7994 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
14:17:34.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.693624  7988 server_base.cc:1061] running on GCE node
14:17:34.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.694131  7988 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:17:34.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.694880  7988 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:17:34.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.696105  7988 hybrid_clock.cc:648] HybridClock initialized: now 1779113854696085 us; error 38 us; skew 500 ppm
14:17:34.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:17:34.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.699939  7988 init.cc:377] Logged in from keytab as kudu/127.7.174.65@KRBTEST.COM (short username kudu)
14:17:34.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.701325  7988 webserver.cc:533] Webserver started at http://127.7.174.65:38105/ using document root <none> and password file <none>
14:17:34.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.702163  7988 fs_manager.cc:362] Metadata directory not provided
14:17:34.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.702248  7988 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:17:34.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.702486  7988 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:17:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.704734  7988 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data/instance:
14:17:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b438fa5ebb944ef9909a9051c6d4687"
14:17:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.705420  7988 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal/instance:
14:17:34.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b438fa5ebb944ef9909a9051c6d4687"
14:17:34.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.709600  7988 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.002s	sys 0.000s
14:17:34.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.712489  8003 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:17:34.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.713810  7988 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
14:17:34.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.713994  7988 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data,/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal
14:17:34.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1b438fa5ebb944ef9909a9051c6d4687"
14:17:34.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.714119  7988 fs_report.cc:389] FS layout report
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data/data
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:17:34.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:17:34.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:17:34.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.727136  7988 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:17:34.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.730858  7988 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:17:34.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.731120  7988 kserver.cc:163] Server-wide thread pool size limit: 3276
14:17:34.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.731880  7988 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:17:34.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.732995  7988 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:17:34.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.733085  7988 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:17:34.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.733145  7988 ts_tablet_manager.cc:616] Registered 0 tablets
14:17:34.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.733168  7988 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:17:34.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.744884  7988 rpc_server.cc:307] RPC server started. Bound to: 127.7.174.65:40875
14:17:34.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.744928  8116 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.174.65:40875 every 8 connection(s)
14:17:34.746 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.746227  7988 server_base.cc:1193] Dumped server information to /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/data/info.pb
14:17:34.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.752260  7865 external_mini_cluster.cc:1428] Started /tmp/dist-test-task5KiCyo/build/debug/bin/kudu as pid 7988
14:17:34.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.752534  7865 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal/instance
14:17:34.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.65@KRBTEST.COM for kudu/127.7.174.126@KRBTEST.COM
14:17:34.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.174.66@KRBTEST.COM; defaulting to no policy
14:17:34.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.174.66@KRBTEST.COM" created.
14:17:34.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.769155  8117 heartbeater.cc:344] Connected to a master server at 127.7.174.126:38337
14:17:34.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.769539  8117 heartbeater.cc:461] Registering TS with master...
14:17:34.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.770285  8117 heartbeater.cc:507] Master 127.7.174.126:38337 requested a full tablet report, sending...
14:17:34.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.772517  7924 ts_manager.cc:194] Registered new tserver with Master: 1b438fa5ebb944ef9909a9051c6d4687 (127.7.174.65:40875)
14:17:34.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.774392  7924 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.174.65@KRBTEST.COM'} at 127.7.174.65:57657
14:17:34.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.174.66@KRBTEST.COM; defaulting to no policy
14:17:34.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.174.66@KRBTEST.COM" created.
14:17:34.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:34.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:34.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.811690  7865 external_mini_cluster.cc:1366] Running /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/logs
14:17:34.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data/info.pb
14:17:34.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:17:34.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:17:34.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:17:34.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:17:34.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.66:0
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.66
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.66
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.66
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:17:34.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:17:34.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:17:34.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:17:34.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:34.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:17:34.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.939667  8124 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:17:34.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.940054  8124 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:17:34.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.940091  8124 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:17:34.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.940166  8124 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:17:34.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.945554  8124 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:17:34.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.945796  8124 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.174.66
14:17:34.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.951323  8124 tablet_server_runner.cc:78] Tablet server non-default flags:
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:34.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.66
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.66:0
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:17:34.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data/info.pb
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.66
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8124
14:17:34.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.66
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/logs
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:17:34.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:44 UTC on bdcb31816ec0
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15851
14:17:34.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.952481  8124 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:17:34.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.953413  8124 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:17:34.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.961768  8129 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
14:17:34.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.961769  8130 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
14:17:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:34.961851  8132 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
14:17:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.962286  8124 server_base.cc:1061] running on GCE node
14:17:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.962761  8124 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:17:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.963479  8124 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:17:34.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.964681  8124 hybrid_clock.cc:648] HybridClock initialized: now 1779113854964614 us; error 79 us; skew 500 ppm
14:17:34.967 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:34 dist-test-slave-8dj5 krb5kdc[7876](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:17:34.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.968309  8124 init.cc:377] Logged in from keytab as kudu/127.7.174.66@KRBTEST.COM (short username kudu)
14:17:34.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.969789  8124 webserver.cc:533] Webserver started at http://127.7.174.66:44583/ using document root <none> and password file <none>
14:17:34.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.970578  8124 fs_manager.cc:362] Metadata directory not provided
14:17:34.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.970669  8124 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:17:34.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.970911  8124 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:17:34.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.973220  8124 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data/instance:
14:17:34.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bbe13432256a48c2a286ca58d54b5792"
14:17:34.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.973879  8124 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal/instance:
14:17:34.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bbe13432256a48c2a286ca58d54b5792"
14:17:34.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.977988  8124 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.000s
14:17:34.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.981297  8139 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:17:34.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.983078  8124 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
14:17:34.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.983237  8124 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data,/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal
14:17:34.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "bbe13432256a48c2a286ca58d54b5792"
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:34 on dist-test-slave-8dj5"
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.983333  8124 fs_report.cc:389] FS layout report
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data/data
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:17:34.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:17:34.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:17:34.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:34.999374  8124 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:17:35.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.002614  8124 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:17:35.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.002794  8124 kserver.cc:163] Server-wide thread pool size limit: 3276
14:17:35.003 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.003407  8124 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:17:35.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.004452  8124 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:17:35.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.004504  8124 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:17:35.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.004547  8124 ts_tablet_manager.cc:616] Registered 0 tablets
14:17:35.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.004565  8124 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:17:35.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.015758  8124 rpc_server.cc:307] RPC server started. Bound to: 127.7.174.66:37819
14:17:35.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.015882  8252 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.174.66:37819 every 8 connection(s)
14:17:35.017 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.016814  8124 server_base.cc:1193] Dumped server information to /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/data/info.pb
14:17:35.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.020203  7865 external_mini_cluster.cc:1428] Started /tmp/dist-test-task5KiCyo/build/debug/bin/kudu as pid 8124
14:17:35.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.020329  7865 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal/instance
14:17:35.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:35 dist-test-slave-8dj5 krb5kdc[7876](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.66@KRBTEST.COM for kudu/127.7.174.126@KRBTEST.COM
14:17:35.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.174.67@KRBTEST.COM; defaulting to no policy
14:17:35.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:35.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.174.67@KRBTEST.COM" created.
14:17:35.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.033779  8253 heartbeater.cc:344] Connected to a master server at 127.7.174.126:38337
14:17:35.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.034097  8253 heartbeater.cc:461] Registering TS with master...
14:17:35.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.034778  8253 heartbeater.cc:507] Master 127.7.174.126:38337 requested a full tablet report, sending...
14:17:35.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.036269  7924 ts_manager.cc:194] Registered new tserver with Master: bbe13432256a48c2a286ca58d54b5792 (127.7.174.66:37819)
14:17:35.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.036897  7924 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.174.66@KRBTEST.COM'} at 127.7.174.66:36317
14:17:35.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:35.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:35.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.174.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:35.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.7.174.67@KRBTEST.COM; defaulting to no policy
14:17:35.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:35.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.7.174.67@KRBTEST.COM" created.
14:17:35.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:17:35.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:35.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.7.174.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab.
14:17:35.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.078744  7865 external_mini_cluster.cc:1366] Running /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task5KiCyo/build/debug/bin/kudu
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/logs
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data/info.pb
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:35.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.67:0
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.67
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.67
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.67
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:35.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:35.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:35.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
14:17:35.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:35.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:17:35.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.194854  8260 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:17:35.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.195165  8260 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
14:17:35.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.195199  8260 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:17:35.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.195267  8260 flags.cc:432] Enabled unsafe flag: --never_fsync=true
14:17:35.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.199250  8260 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
14:17:35.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.199455  8260 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.174.67
14:17:35.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.204445  8260 tablet_server_runner.cc:78] Tablet server non-default flags:
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.174.84:40115
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kudu.keytab
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.174.67
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.174.67:0
14:17:35.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data/info.pb
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.174.67
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.174.126:38337
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:17:35.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8260
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.174.67
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/logs
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bee9a2d051767e07c70d440ae169cb7177a10f8
14:17:35.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
14:17:35.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 18 May 2026 14:03:44 UTC on bdcb31816ec0
14:17:35.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 15851
14:17:35.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.206125  8260 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:17:35.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.207355  8260 file_cache.cc:492] Constructed file cache file cache with capacity 419430
14:17:35.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.214874  8266 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
14:17:35.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.215090  8265 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
14:17:35.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:35.214874  8268 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
14:17:35.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.215641  8260 server_base.cc:1061] running on GCE node
14:17:35.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.216356  8260 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:17:35.217 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.217204  8260 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:17:35.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.218393  8260 hybrid_clock.cc:648] HybridClock initialized: now 1779113855218363 us; error 47 us; skew 500 ppm
14:17:35.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:35 dist-test-slave-8dj5 krb5kdc[7876](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113855, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:17:35.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.221827  8260 init.cc:377] Logged in from keytab as kudu/127.7.174.67@KRBTEST.COM (short username kudu)
14:17:35.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.223076  8260 webserver.cc:533] Webserver started at http://127.7.174.67:37905/ using document root <none> and password file <none>
14:17:35.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.223634  8260 fs_manager.cc:362] Metadata directory not provided
14:17:35.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.223687  8260 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:17:35.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.223858  8260 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.225623  8260 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data/instance:
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca450d51f8844eb59ca502e85cde508d"
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:35 on dist-test-slave-8dj5"
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.226205  8260 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal/instance:
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca450d51f8844eb59ca502e85cde508d"
14:17:35.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:35 on dist-test-slave-8dj5"
14:17:35.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.230022  8260 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
14:17:35.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.232566  8275 log_block_manager.cc:3869] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.234059  8260 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.234216  8260 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data,/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ca450d51f8844eb59ca502e85cde508d"
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-05-18 14:17:35 on dist-test-slave-8dj5"
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.234335  8260 fs_report.cc:389] FS layout report
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal
14:17:35.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data/data
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:17:35.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:17:35.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.246860  8260 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
14:17:35.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.250263  8260 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:17:35.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.250511  8260 kserver.cc:163] Server-wide thread pool size limit: 3276
14:17:35.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.251243  8260 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
14:17:35.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.252326  8260 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:17:35.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.252408  8260 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:17:35.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.252470  8260 ts_tablet_manager.cc:616] Registered 0 tablets
14:17:35.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.252492  8260 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:17:35.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.263586  8260 rpc_server.cc:307] RPC server started. Bound to: 127.7.174.67:45339
14:17:35.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.263602  8388 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.7.174.67:45339 every 8 connection(s)
14:17:35.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.264745  8260 server_base.cc:1193] Dumped server information to /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/data/info.pb
14:17:35.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.266381  7865 external_mini_cluster.cc:1428] Started /tmp/dist-test-task5KiCyo/build/debug/bin/kudu as pid 8260
14:17:35.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.266494  7865 external_mini_cluster.cc:1442] Reading /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal/instance
14:17:35.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:35 dist-test-slave-8dj5 krb5kdc[7876](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1779113855, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.174.67@KRBTEST.COM for kudu/127.7.174.126@KRBTEST.COM
14:17:35.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.280970  8389 heartbeater.cc:344] Connected to a master server at 127.7.174.126:38337
14:17:35.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.281294  8389 heartbeater.cc:461] Registering TS with master...
14:17:35.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.281958  8389 heartbeater.cc:507] Master 127.7.174.126:38337 requested a full tablet report, sending...
14:17:35.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.283143  7923 ts_manager.cc:194] Registered new tserver with Master: ca450d51f8844eb59ca502e85cde508d (127.7.174.67:45339)
14:17:35.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.283735  7923 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.174.67@KRBTEST.COM'} at 127.7.174.67:58041
14:17:35.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.295035  7865 external_mini_cluster.cc:949] 3 TS(s) registered with all masters
14:17:35.296 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:17:35.297 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

14:17:35.305 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

14:17:35.306 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:17:35.315 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.174.126"
      port: 38337
    }
    bound_http_address {
      host: "127.7.174.126"
      port: 39137
    }
  }
}

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

14:17:35.321 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.174.65"
      port: 40875
    }
    bound_http_address {
      host: "127.7.174.65"
      port: 38105
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.174.66"
      port: 37819
    }
    bound_http_address {
      host: "127.7.174.66"
      port: 44583
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.174.67"
      port: 45339
    }
    bound_http_address {
      host: "127.7.174.67"
      port: 37905
    }
  }
}

14:17:35.321 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:17:35.528 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
14:17:35.550 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/krb5kdc/krb5cc
14:17:35.609 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
14:17:35.750 [DEBUG - main] (Connection.java:748) [peer master-127.7.174.126:38337(127.7.174.126:38337)] connecting to peer
14:17:35.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:35.777438  8117 heartbeater.cc:499] Master 127.7.174.126:38337 was elected leader, sending a full tablet report...
14:17:35.822 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.174.126:38337(127.7.174.126:38337)] Successfully connected to peer
14:17:35.916 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.7.174.126
14:17:36.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.039644  8253 heartbeater.cc:499] Master 127.7.174.126:38337 was elected leader, sending a full tablet report...
14:17:36.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) May 18 14:17:36 dist-test-slave-8dj5 krb5kdc[7876](info): TGS_REQ (1 etypes {17}) 127.0.0.1: ISSUE: authtime 1779113854, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.174.126@KRBTEST.COM
14:17:36.231 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xe6e945a2, L:/127.0.0.1:52548 - R:/127.7.174.126:38337] using SASL/GSSAPI
14:17:36.280 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:17:36.281 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=574), Traces: [0ms] refreshing cache from master, [24ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.174.126:38337, [544ms] Sub RPC ConnectToMaster: received response from server master-127.7.174.126:38337: OK, deferred=null) after lookup
14:17:36.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.285972  8389 heartbeater.cc:499] Master 127.7.174.126:38337 was elected leader, sending a full tablet report...
14:17:36.302 [DEBUG - main] (Connection.java:575) [peer master-127.7.174.126:38337(127.7.174.126:38337)] disconnecting while in state READY
14:17:36.310 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.174.126:38337(127.7.174.126:38337)] handling channelInactive
14:17:36.311 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.174.126:38337(127.7.174.126:38337)] cleaning up while in state READY due to: connection closed
14:17:36.312 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.7.174.126:38337(127.7.174.126:38337) for tablet Kudu Master: connection closed
14:17:36.330 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.7.174.126:38337(127.7.174.126:38337)] connecting to peer
14:17:36.333 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.174.126:38337(127.7.174.126:38337)] Successfully connected to peer
14:17:36.409 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x9a4d6578, L:/127.0.0.1:52560 - R:/127.7.174.126:38337] using TOKEN/null
14:17:36.412 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:17:36.413 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=110), Traces: [0ms] sending RPC to server master-127.7.174.126:38337, [9ms] received response from server master-127.7.174.126:38337: Network error: connection closed, [9ms] delaying RPC due to: Network error: connection closed, [26ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.174.126:38337, [109ms] Sub RPC ConnectToMaster: received response from server master-127.7.174.126:38337: OK, deferred=Deferred@1273897508(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.494607  7923 catalog_manager.cc:2283] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:52560:
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:17:36.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:17:36.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:17:36.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:17:36.500 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:36.497510  7923 catalog_manager.cc:7059] 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.
14:17:36.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.520143  8051 tablet_service.cc:1511] Processing CreateTablet for tablet ba7110d1146f47ad9174e5746febdd82 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]), partition=RANGE (key) PARTITION UNBOUNDED
14:17:36.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.521971  8051 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ba7110d1146f47ad9174e5746febdd82. 1 dirs total, 0 dirs full, 0 dirs failed
14:17:36.528 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 6cadfeddd4f04650909b9958db3f37f0
14:17:36.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.526130  8323 tablet_service.cc:1511] Processing CreateTablet for tablet ba7110d1146f47ad9174e5746febdd82 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]), partition=RANGE (key) PARTITION UNBOUNDED
14:17:36.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.527288  8323 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ba7110d1146f47ad9174e5746febdd82. 1 dirs total, 0 dirs full, 0 dirs failed
14:17:36.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.527932  8187 tablet_service.cc:1511] Processing CreateTablet for tablet ba7110d1146f47ad9174e5746febdd82 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]), partition=RANGE (key) PARTITION UNBOUNDED
14:17:36.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.528992  8187 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ba7110d1146f47ad9174e5746febdd82. 1 dirs total, 0 dirs full, 0 dirs failed
14:17:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.536324  8407 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Bootstrap starting.
14:17:36.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.536326  8408 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Bootstrap starting.
14:17:36.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.539126  8409 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Bootstrap starting.
14:17:36.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.539213  8407 tablet_bootstrap.cc:654] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Neither blocks nor log segments found. Creating new log.
14:17:36.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.539633  8408 tablet_bootstrap.cc:654] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Neither blocks nor log segments found. Creating new log.
14:17:36.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.540323  8407 log.cc:826] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Log is configured to *not* fsync() on all Append() calls
14:17:36.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.540510  8408 log.cc:826] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Log is configured to *not* fsync() on all Append() calls
14:17:36.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.542371  8409 tablet_bootstrap.cc:654] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Neither blocks nor log segments found. Creating new log.
14:17:36.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.542635  8408 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: No bootstrap required, opened a new log
14:17:36.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.542654  8407 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: No bootstrap required, opened a new log
14:17:36.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.542861  8407 ts_tablet_manager.cc:1403] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Time spent bootstrapping tablet: real 0.007s	user 0.004s	sys 0.000s
14:17:36.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.542865  8408 ts_tablet_manager.cc:1403] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
14:17:36.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.544018  8409 log.cc:826] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Log is configured to *not* fsync() on all Append() calls
14:17:36.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.547024  8408 raft_consensus.cc:359] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.547024  8407 raft_consensus.cc:359] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.547344  8407 raft_consensus.cc:385] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:17:36.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.547415  8407 raft_consensus.cc:740] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ca450d51f8844eb59ca502e85cde508d, State: Initialized, Role: FOLLOWER
14:17:36.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.548041  8408 raft_consensus.cc:385] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:17:36.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.548337  8408 raft_consensus.cc:740] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1b438fa5ebb944ef9909a9051c6d4687, State: Initialized, Role: FOLLOWER
14:17:36.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.549021  8408 consensus_queue.cc:260] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [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: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.550469  8408 ts_tablet_manager.cc:1434] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Time spent starting tablet: real 0.008s	user 0.007s	sys 0.000s
14:17:36.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.548031  8407 consensus_queue.cc:260] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [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: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.552038  8407 ts_tablet_manager.cc:1434] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Time spent starting tablet: real 0.009s	user 0.003s	sys 0.004s
14:17:36.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.554390  8409 tablet_bootstrap.cc:492] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: No bootstrap required, opened a new log
14:17:36.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.554659  8409 ts_tablet_manager.cc:1403] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Time spent bootstrapping tablet: real 0.016s	user 0.006s	sys 0.000s
14:17:36.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.564383  8409 raft_consensus.cc:359] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.564733  8409 raft_consensus.cc:385] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:17:36.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.564790  8409 raft_consensus.cc:740] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: bbe13432256a48c2a286ca58d54b5792, State: Initialized, Role: FOLLOWER
14:17:36.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.565344  8409 consensus_queue.cc:260] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [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: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.566522  8409 ts_tablet_manager.cc:1434] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Time spent starting tablet: real 0.012s	user 0.002s	sys 0.004s
14:17:36.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.598340  8412 raft_consensus.cc:493] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:17:36.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.598619  8412 raft_consensus.cc:515] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.600009  8412 leader_election.cc:290] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers ca450d51f8844eb59ca502e85cde508d (127.7.174.67:45339), bbe13432256a48c2a286ca58d54b5792 (127.7.174.66:37819)
14:17:36.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.605150  8207 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ba7110d1146f47ad9174e5746febdd82" candidate_uuid: "1b438fa5ebb944ef9909a9051c6d4687" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bbe13432256a48c2a286ca58d54b5792" is_pre_election: true
14:17:36.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.605275  8343 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ba7110d1146f47ad9174e5746febdd82" candidate_uuid: "1b438fa5ebb944ef9909a9051c6d4687" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ca450d51f8844eb59ca502e85cde508d" is_pre_election: true
14:17:36.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.605505  8207 raft_consensus.cc:2468] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1b438fa5ebb944ef9909a9051c6d4687 in term 0.
14:17:36.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.605581  8343 raft_consensus.cc:2468] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1b438fa5ebb944ef9909a9051c6d4687 in term 0.
14:17:36.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.606133  8007 leader_election.cc:304] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [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: 1b438fa5ebb944ef9909a9051c6d4687, bbe13432256a48c2a286ca58d54b5792; no voters: 
14:17:36.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.606489  8412 raft_consensus.cc:2804] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:17:36.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.606582  8412 raft_consensus.cc:493] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:17:36.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.606645  8412 raft_consensus.cc:3060] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 0 FOLLOWER]: Advancing to term 1
14:17:36.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.607867  8412 raft_consensus.cc:515] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.608408  8412 leader_election.cc:290] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [CANDIDATE]: Term 1 election: Requested vote from peers ca450d51f8844eb59ca502e85cde508d (127.7.174.67:45339), bbe13432256a48c2a286ca58d54b5792 (127.7.174.66:37819)
14:17:36.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.608891  8343 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ba7110d1146f47ad9174e5746febdd82" candidate_uuid: "1b438fa5ebb944ef9909a9051c6d4687" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "ca450d51f8844eb59ca502e85cde508d"
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.609040  8343 raft_consensus.cc:3060] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 0 FOLLOWER]: Advancing to term 1
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.609035  8207 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ba7110d1146f47ad9174e5746febdd82" candidate_uuid: "1b438fa5ebb944ef9909a9051c6d4687" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "bbe13432256a48c2a286ca58d54b5792"
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.609171  8207 raft_consensus.cc:3060] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 0 FOLLOWER]: Advancing to term 1
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.610199  8207 raft_consensus.cc:2468] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1b438fa5ebb944ef9909a9051c6d4687 in term 1.
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.610301  8343 raft_consensus.cc:2468] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1b438fa5ebb944ef9909a9051c6d4687 in term 1.
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.610874  8007 leader_election.cc:304] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [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: 1b438fa5ebb944ef9909a9051c6d4687, bbe13432256a48c2a286ca58d54b5792; no voters: 
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.611320  8412 raft_consensus.cc:2804] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 1 FOLLOWER]: Leader election won for term 1
14:17:36.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.611655  8412 raft_consensus.cc:697] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 1 LEADER]: Becoming Leader. State: Replica: 1b438fa5ebb944ef9909a9051c6d4687, State: Running, Role: LEADER
14:17:36.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.612175  8412 consensus_queue.cc:237] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [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: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } }
14:17:36.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.617170  7923 catalog_manager.cc:5697] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 reported cstate change: term changed from 0 to 1, leader changed from <none> to 1b438fa5ebb944ef9909a9051c6d4687 (127.7.174.65). New cstate: current_term: 1 leader_uuid: "1b438fa5ebb944ef9909a9051c6d4687" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1b438fa5ebb944ef9909a9051c6d4687" member_type: VOTER last_known_addr { host: "127.7.174.65" port: 40875 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 } health_report { overall_health: UNKNOWN } } }
14:17:36.636 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 6cadfeddd4f04650909b9958db3f37f0
14:17:36.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:36.748879  8118 tablet.cc:2404] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:17:36.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:36.767076  8390 tablet.cc:2404] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:17:36.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:36.771529  8254 tablet.cc:2404] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:17:36.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:36.997077  8418 consensus_queue.cc:1048] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [LEADER]: Connected to new peer: Peer: permanent_uuid: "bbe13432256a48c2a286ca58d54b5792" member_type: VOTER last_known_addr { host: "127.7.174.66" port: 37819 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:17:37.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:37.003935  8418 consensus_queue.cc:1048] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [LEADER]: Connected to new peer: Peer: permanent_uuid: "ca450d51f8844eb59ca502e85cde508d" member_type: VOTER last_known_addr { host: "127.7.174.67" port: 45339 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:17:37.640 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 6cadfeddd4f04650909b9958db3f37f0
14:17:37.664 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet ba7110d1146f47ad9174e5746febdd82 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
14:17:37.670 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=ba7110d1146f47ad9174e5746febdd82@[1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)[L],bbe13432256a48c2a286ca58d54b5792(127.7.174.66:37819),ca450d51f8844eb59ca502e85cde508d(127.7.174.67:45339)]}]
14:17:37.679 [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=18), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.174.126:38337, [9ms] Sub RPC GetTableLocations: received response from server master-127.7.174.126:38337: OK, deferred=null)) after lookup
14:17:37.691 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.694 [DEBUG - kudu-nio-2] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:37.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.741667  8430 fault_injection.cc:43] FAULT INJECTION ENABLED!
14:17:37.742 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.741770  8430 fault_injection.cc:44] THIS SERVER MAY CRASH!
14:17:37.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.742357  8430 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:37166: token signing key expired
14:17:37.748 [DEBUG - kudu-nio-2] (Negotiator.java:352) peer /127.7.174.65:40875 sent connection negotiation error: Not authorized: token signing key expired
14:17:37.751 [DEBUG - kudu-nio-2] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:37.752 [DEBUG - kudu-nio-2] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:17:37.754 [DEBUG - kudu-nio-2] (Connection.java:748) [peer master-127.7.174.126:38337(127.7.174.126:38337)] connecting to peer
14:17:37.757 [DEBUG - kudu-nio-3] (Connection.java:757) [peer master-127.7.174.126:38337(127.7.174.126:38337)] Successfully connected to peer
14:17:37.765 [DEBUG - kudu-nio-3] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.7.174.126
14:17:37.808 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0x38b260f2, L:/127.0.0.1:52574 - R:/127.7.174.126:38337] using SASL/GSSAPI
14:17:37.812 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:17:37.813 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.815 [DEBUG - kudu-nio-4] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:37.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.838599  8430 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:37180: invalid token signature
14:17:37.840 [DEBUG - kudu-nio-4] (Negotiator.java:352) peer /127.7.174.65:40875 sent connection negotiation error: Not authorized: invalid token signature
14:17:37.841 [DEBUG - kudu-nio-4] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:37.842 [DEBUG - kudu-nio-4] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:17:37.845 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:17:37.845 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.847 [DEBUG - kudu-nio-5] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:37.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.884485  8430 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:37184: token signing key expired
14:17:37.886 [DEBUG - kudu-nio-5] (Negotiator.java:352) peer /127.7.174.65:40875 sent connection negotiation error: Not authorized: token signing key expired
14:17:37.888 [DEBUG - kudu-nio-5] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:37.888 [DEBUG - kudu-nio-5] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:17:37.893 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:17:37.894 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.896 [DEBUG - kudu-nio-6] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:37.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.926443  8430 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:37200: token expired
14:17:37.929 [DEBUG - kudu-nio-6] (Negotiator.java:352) peer /127.7.174.65:40875 sent connection negotiation error: Not authorized: token expired
14:17:37.931 [DEBUG - kudu-nio-6] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:37.931 [DEBUG - kudu-nio-6] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:17:37.939 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:17:37.940 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.945 [DEBUG - kudu-nio-7] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:37.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260518 14:17:37.978641  8430 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:37214: invalid token
14:17:37.980 [DEBUG - kudu-nio-7] (Negotiator.java:352) peer /127.7.174.65:40875 sent connection negotiation error: Not authorized: invalid token
14:17:37.982 [DEBUG - kudu-nio-7] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:37.982 [DEBUG - kudu-nio-7] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:17:37.986 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:17:37.987 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] connecting to peer
14:17:37.993 [DEBUG - kudu-nio-0] (Connection.java:757) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] Successfully connected to peer
14:17:38.024 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xeea6d791, L:/127.0.0.1:37228 - R:/127.7.174.65:40875] using TOKEN/null
14:17:38.060 [DEBUG - kudu-nio-0] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=ba7110d1146f47ad9174e5746febdd82, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:17:38.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.074257  7918 catalog_manager.cc:2533] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52574:
14:17:38.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:17:38.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.074471  7918 catalog_manager.cc:2781] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52574:
14:17:38.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:17:38.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.078936  7918 catalog_manager.cc:5984] T 00000000000000000000000000000000 P d2b284c22ac14517a51a94738c9f029f: Sending DeleteTablet for 3 replicas of tablet ba7110d1146f47ad9174e5746febdd82
14:17:38.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.080008  8187 tablet_service.cc:1558] Processing DeleteTablet for tablet ba7110d1146f47ad9174e5746febdd82 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:17:38 UTC) from {username='kudu', principal='kudu/127.7.174.126@KRBTEST.COM'} at 127.0.0.1:35240
14:17:38.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.080248  8051 tablet_service.cc:1558] Processing DeleteTablet for tablet ba7110d1146f47ad9174e5746febdd82 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:17:38 UTC) from {username='kudu', principal='kudu/127.7.174.126@KRBTEST.COM'} at 127.0.0.1:37156
14:17:38.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.080713  8323 tablet_service.cc:1558] Processing DeleteTablet for tablet ba7110d1146f47ad9174e5746febdd82 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-05-18 14:17:38 UTC) from {username='kudu', principal='kudu/127.7.174.126@KRBTEST.COM'} at 127.0.0.1:48584
14:17:38.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.080914  8443 tablet_replica.cc:333] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: stopping tablet replica
14:17:38.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.081244  8443 raft_consensus.cc:2243] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 1 FOLLOWER]: Raft consensus shutting down.
14:17:38.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.081759  8443 raft_consensus.cc:2272] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792 [term 1 FOLLOWER]: Raft consensus is shut down!
14:17:38.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.083181  8443 ts_tablet_manager.cc:1916] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Deleting tablet data with delete state TABLET_DATA_DELETED
14:17:38.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.086287  8445 tablet_replica.cc:333] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: stopping tablet replica
14:17:38.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.087342  8445 raft_consensus.cc:2243] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 1 FOLLOWER]: Raft consensus shutting down.
14:17:38.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.088172  8444 tablet_replica.cc:333] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: stopping tablet replica
14:17:38.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.088480  8444 raft_consensus.cc:2243] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 1 LEADER]: Raft consensus shutting down.
14:17:38.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.088827  8445 raft_consensus.cc:2272] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d [term 1 FOLLOWER]: Raft consensus is shut down!
14:17:38.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.089118  8444 raft_consensus.cc:2272] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687 [term 1 FOLLOWER]: Raft consensus is shut down!
14:17:38.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.090304  8443 ts_tablet_manager.cc:1929] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:17:38.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.090696  8444 ts_tablet_manager.cc:1916] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Deleting tablet data with delete state TABLET_DATA_DELETED
14:17:38.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.091599  8445 ts_tablet_manager.cc:1916] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Deleting tablet data with delete state TABLET_DATA_DELETED
14:17:38.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.093813  8443 log.cc:1199] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Deleting WAL directory at /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-1/wal/wals/ba7110d1146f47ad9174e5746febdd82
14:17:38.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.094261  8444 ts_tablet_manager.cc:1929] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:17:38.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.095408  8443 ts_tablet_manager.cc:1950] T ba7110d1146f47ad9174e5746febdd82 P bbe13432256a48c2a286ca58d54b5792: Deleting consensus metadata
14:17:38.096 [DEBUG - main] (Connection.java:575) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] disconnecting while in state READY
14:17:38.097 [DEBUG - main] (Connection.java:575) [peer master-127.7.174.126:38337(127.7.174.126:38337)] disconnecting while in state READY
14:17:38.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.097426  7911 catalog_manager.cc:5028] TS bbe13432256a48c2a286ca58d54b5792 (127.7.174.66:37819): tablet ba7110d1146f47ad9174e5746febdd82 (table TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]) successfully deleted
14:17:38.097 [DEBUG - main] (Connection.java:575) [peer master-127.7.174.126:38337(127.7.174.126:38337)] disconnecting while in state READY
14:17:38.099 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.174.126:38337(127.7.174.126:38337)] handling channelInactive
14:17:38.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.099058  8445 ts_tablet_manager.cc:1929] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:17:38.099 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.174.126:38337(127.7.174.126:38337)] cleaning up while in state READY due to: connection closed
14:17:38.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.099409  8445 log.cc:1199] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Deleting WAL directory at /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-2/wal/wals/ba7110d1146f47ad9174e5746febdd82
14:17:38.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.099807  8445 ts_tablet_manager.cc:1950] T ba7110d1146f47ad9174e5746febdd82 P ca450d51f8844eb59ca502e85cde508d: Deleting consensus metadata
14:17:38.100 [DEBUG - kudu-nio-0] (Connection.java:239) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] handling channelInactive
14:17:38.100 [DEBUG - kudu-nio-0] (Connection.java:709) [peer 1b438fa5ebb944ef9909a9051c6d4687(127.7.174.65:40875)] cleaning up while in state READY due to: connection closed
14:17:38.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.101054  8444 log.cc:1199] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Deleting WAL directory at /tmp/dist-test-task5KiCyo/test-tmp/mini-kudu-cluster12996722488196901074/ts-0/wal/wals/ba7110d1146f47ad9174e5746febdd82
14:17:38.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.101722  8444 ts_tablet_manager.cc:1950] T ba7110d1146f47ad9174e5746febdd82 P 1b438fa5ebb944ef9909a9051c6d4687: Deleting consensus metadata
14:17:38.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.103120  7908 catalog_manager.cc:5028] TS ca450d51f8844eb59ca502e85cde508d (127.7.174.67:45339): tablet ba7110d1146f47ad9174e5746febdd82 (table TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]) successfully deleted
14:17:38.103 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:17:38.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.103488  7909 catalog_manager.cc:5028] TS 1b438fa5ebb944ef9909a9051c6d4687 (127.7.174.65:40875): tablet ba7110d1146f47ad9174e5746febdd82 (table TestAuthnTokenReacquireOpen-table [id=6cadfeddd4f04650909b9958db3f37f0]) successfully deleted
14:17:38.105 [DEBUG - kudu-nio-3] (Connection.java:239) [peer master-127.7.174.126:38337(127.7.174.126:38337)] handling channelInactive
14:17:38.105 [DEBUG - kudu-nio-3] (Connection.java:709) [peer master-127.7.174.126:38337(127.7.174.126:38337)] cleaning up while in state READY due to: connection closed
14:17:38.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.106853  7865 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task5KiCyo/build/debug/bin/kudu with pid 7988
14:17:38.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.114524  7865 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task5KiCyo/build/debug/bin/kudu with pid 8124
14:17:38.121 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.120905  7865 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task5KiCyo/build/debug/bin/kudu with pid 8260
14:17:38.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260518 14:17:38.127594  7865 external_mini_cluster.cc:1658] Killing /tmp/dist-test-task5KiCyo/build/debug/bin/kudu with pid 7892
14:17:38.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-05-18T14:17:38Z chronyd exiting

Time: 6.508

OK (1 test)

