{"level":"warn","ts":"2026-05-12T05:39:32.960881Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-12T05:39:32.961005Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-12T05:39:32.961944Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-12T05:39:32.961968Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-12T05:39:32.961993Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-12T05:39:32.962943Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]}
{"level":"info","ts":"2026-05-12T05:39:32.9631Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-12T05:39:32.968659Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.216654ms"}
{"level":"info","ts":"2026-05-12T05:39:32.975534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"}
{"level":"info","ts":"2026-05-12T05:39:32.975756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-12T05:39:32.975795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"}
{"level":"info","ts":"2026-05-12T05:39:32.975814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-12T05:39:32.975887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"}
{"level":"info","ts":"2026-05-12T05:39:32.976072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"warn","ts":"2026-05-12T05:39:32.981568Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-12T05:39:32.982769Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-12T05:39:32.983704Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-12T05:39:32.985994Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-12T05:39:32.989221Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-12T05:39:32.989561Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-12T05:39:32.989588Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-12T05:39:32.989447Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-12T05:39:32.990765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"}
{"level":"info","ts":"2026-05-12T05:39:32.9909Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]}
{"level":"info","ts":"2026-05-12T05:39:32.991251Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-12T05:39:32.99144Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-12T05:39:32.99146Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-12T05:39:32.991522Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-12T05:39:32.991534Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"}
{"level":"info","ts":"2026-05-12T05:39:33.276756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-12T05:39:33.276821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-12T05:39:33.27688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"}
{"level":"info","ts":"2026-05-12T05:39:33.277121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"}
{"level":"info","ts":"2026-05-12T05:39:33.277142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-12T05:39:33.277246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"}
{"level":"info","ts":"2026-05-12T05:39:33.277279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"}
{"level":"info","ts":"2026-05-12T05:39:33.279388Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-12T05:39:33.279616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-12T05:39:33.279653Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-12T05:39:33.279859Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-12T05:39:33.279929Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-12T05:39:33.279972Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:39:33.281038Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:39:33.281099Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:39:33.28112Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-12T05:39:33.2823Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-12T05:39:33.28361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"}
{"level":"warn","ts":"2026-05-12T05:39:34.999072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.374432ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831755320193157 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-05-12T05:39:34.999395Z","caller":"traceutil/trace.go:171","msg":"trace[282360709] linearizableReadLoop","detail":"{readStateIndex:11; appliedIndex:6; }","duration":"382.348757ms","start":"2026-05-12T05:39:34.61703Z","end":"2026-05-12T05:39:34.999379Z","steps":["trace[282360709] 'read index received'  (duration: 25.284896ms)","trace[282360709] 'applied index is now lower than readState.Index'  (duration: 357.062931ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:39:34.999473Z","caller":"traceutil/trace.go:171","msg":"trace[1532174750] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"382.398648ms","start":"2026-05-12T05:39:34.617066Z","end":"2026-05-12T05:39:34.999464Z","steps":["trace[1532174750] 'process raft request'  (duration: 382.216586ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:34.999528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.61705Z","time spent":"382.450728ms","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:39:34.999606Z","caller":"traceutil/trace.go:171","msg":"trace[1998800976] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"382.966094ms","start":"2026-05-12T05:39:34.616571Z","end":"2026-05-12T05:39:34.999537Z","steps":["trace[1998800976] 'process raft request'  (duration: 193.592051ms)","trace[1998800976] 'compare'  (duration: 188.25553ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:39:34.999653Z","caller":"traceutil/trace.go:171","msg":"trace[1154198434] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"382.762522ms","start":"2026-05-12T05:39:34.61681Z","end":"2026-05-12T05:39:34.999573Z","steps":["trace[1154198434] 'process raft request'  (duration: 382.384708ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:34.999756Z","caller":"traceutil/trace.go:171","msg":"trace[677646842] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"365.078475ms","start":"2026-05-12T05:39:34.634667Z","end":"2026-05-12T05:39:34.999746Z","steps":["trace[677646842] 'process raft request'  (duration: 364.67432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:34.999819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.634641Z","time spent":"365.150126ms","remote":"127.0.0.1:44970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-wwnpk\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-wwnpk\" value_size:795 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:34.999837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.616784Z","time spent":"382.961385ms","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:39:34.999894Z","caller":"traceutil/trace.go:171","msg":"trace[1521206970] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"382.827404ms","start":"2026-05-12T05:39:34.616974Z","end":"2026-05-12T05:39:34.999802Z","steps":["trace[1521206970] 'process raft request'  (duration: 382.261886ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:34.999528Z","caller":"traceutil/trace.go:171","msg":"trace[955793225] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"382.449129ms","start":"2026-05-12T05:39:34.61697Z","end":"2026-05-12T05:39:34.99942Z","steps":["trace[955793225] 'process raft request'  (duration: 382.287047ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:34.999974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.616958Z","time spent":"382.988655ms","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:39:34.999951Z","caller":"traceutil/trace.go:171","msg":"trace[111447239] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"374.469986ms","start":"2026-05-12T05:39:34.625437Z","end":"2026-05-12T05:39:34.999907Z","steps":["trace[111447239] 'process raft request'  (duration: 373.876018ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.000027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.616965Z","time spent":"382.988195ms","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:35.000091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.625426Z","time spent":"374.600837ms","remote":"127.0.0.1:44900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:34.999811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.616552Z","time spent":"383.166798ms","remote":"127.0.0.1:45270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:34.999981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.943465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-12T05:39:35.000219Z","caller":"traceutil/trace.go:171","msg":"trace[1605296900] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"383.209378ms","start":"2026-05-12T05:39:34.616995Z","end":"2026-05-12T05:39:35.000205Z","steps":["trace[1605296900] 'agreement among raft nodes before linearized reading'  (duration: 382.926735ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.000272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.616986Z","time spent":"383.268529ms","remote":"127.0.0.1:45122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-05-12T05:39:35.062206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.325548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-05-12T05:39:35.062213Z","caller":"traceutil/trace.go:171","msg":"trace[337389105] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"411.299256ms","start":"2026-05-12T05:39:34.65089Z","end":"2026-05-12T05:39:35.062189Z","steps":["trace[337389105] 'process raft request'  (duration: 411.194185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.062252Z","caller":"traceutil/trace.go:171","msg":"trace[1636084745] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"395.381108ms","start":"2026-05-12T05:39:34.666863Z","end":"2026-05-12T05:39:35.062245Z","steps":["trace[1636084745] 'agreement among raft nodes before linearized reading'  (duration: 395.282257ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.062275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.666851Z","time spent":"395.418029ms","remote":"127.0.0.1:44812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-12T05:39:35.062266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.077696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-12T05:39:35.062332Z","caller":"traceutil/trace.go:171","msg":"trace[1763166659] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"412.248476ms","start":"2026-05-12T05:39:34.650063Z","end":"2026-05-12T05:39:35.062311Z","steps":["trace[1763166659] 'process raft request'  (duration: 412.004673ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.062342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.650878Z","time spent":"411.387327ms","remote":"127.0.0.1:45188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/node-high\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/node-high\" value_size:649 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:35.062412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.650047Z","time spent":"412.330217ms","remote":"127.0.0.1:44812","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"info","ts":"2026-05-12T05:39:35.062427Z","caller":"traceutil/trace.go:171","msg":"trace[1797273224] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:13; }","duration":"269.278968ms","start":"2026-05-12T05:39:34.793119Z","end":"2026-05-12T05:39:35.062398Z","steps":["trace[1797273224] 'agreement among raft nodes before linearized reading'  (duration: 269.025315ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.06224Z","caller":"traceutil/trace.go:171","msg":"trace[478312406] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"413.934626ms","start":"2026-05-12T05:39:34.648288Z","end":"2026-05-12T05:39:35.062222Z","steps":["trace[478312406] 'process raft request'  (duration: 413.712164ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.06277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.648274Z","time spent":"414.451663ms","remote":"127.0.0.1:44812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"warn","ts":"2026-05-12T05:39:35.063051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.631965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-12T05:39:35.063135Z","caller":"traceutil/trace.go:171","msg":"trace[177456174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13; }","duration":"414.762406ms","start":"2026-05-12T05:39:34.648345Z","end":"2026-05-12T05:39:35.063107Z","steps":["trace[177456174] 'agreement among raft nodes before linearized reading'  (duration: 414.596144ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.063239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:34.648333Z","time spent":"414.844227ms","remote":"127.0.0.1:44676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-12T05:39:35.301019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.121106ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831755320193168 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" value_size:890 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-05-12T05:39:35.301292Z","caller":"traceutil/trace.go:171","msg":"trace[459287792] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"295.712952ms","start":"2026-05-12T05:39:35.005549Z","end":"2026-05-12T05:39:35.301262Z","steps":["trace[459287792] 'process raft request'  (duration: 104.276403ms)","trace[459287792] 'compare'  (duration: 190.966664ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:39:35.301312Z","caller":"traceutil/trace.go:171","msg":"trace[717564698] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:17; }","duration":"239.170691ms","start":"2026-05-12T05:39:35.062124Z","end":"2026-05-12T05:39:35.301295Z","steps":["trace[717564698] 'read index received'  (duration: 47.66154ms)","trace[717564698] 'applied index is now lower than readState.Index'  (duration: 191.508061ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:39:35.301309Z","caller":"traceutil/trace.go:171","msg":"trace[697465706] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"295.656832ms","start":"2026-05-12T05:39:35.005589Z","end":"2026-05-12T05:39:35.301246Z","steps":["trace[697465706] 'process raft request'  (duration: 295.520841ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.30142Z","caller":"traceutil/trace.go:171","msg":"trace[1997732824] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"290.639165ms","start":"2026-05-12T05:39:35.010771Z","end":"2026-05-12T05:39:35.30141Z","steps":["trace[1997732824] 'process raft request'  (duration: 290.467413ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.301519Z","caller":"traceutil/trace.go:171","msg":"trace[445499028] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"295.138026ms","start":"2026-05-12T05:39:35.006356Z","end":"2026-05-12T05:39:35.301494Z","steps":["trace[445499028] 'process raft request'  (duration: 294.829083ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.301618Z","caller":"traceutil/trace.go:171","msg":"trace[86282564] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"295.741813ms","start":"2026-05-12T05:39:35.005837Z","end":"2026-05-12T05:39:35.301579Z","steps":["trace[86282564] 'process raft request'  (duration: 295.323968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.301694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.796876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-wwnpk\" ","response":"range_response_count:1 size:861"}
{"level":"warn","ts":"2026-05-12T05:39:35.301696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.891837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"}
{"level":"info","ts":"2026-05-12T05:39:35.301737Z","caller":"traceutil/trace.go:171","msg":"trace[763262071] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-wwnpk; range_end:; response_count:1; response_revision:19; }","duration":"297.882479ms","start":"2026-05-12T05:39:35.003844Z","end":"2026-05-12T05:39:35.301727Z","steps":["trace[763262071] 'agreement among raft nodes before linearized reading'  (duration: 297.793068ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.301737Z","caller":"traceutil/trace.go:171","msg":"trace[134472968] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"293.470356ms","start":"2026-05-12T05:39:35.00825Z","end":"2026-05-12T05:39:35.30172Z","steps":["trace[134472968] 'process raft request'  (duration: 292.958131ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.301759Z","caller":"traceutil/trace.go:171","msg":"trace[398520417] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"296.999928ms","start":"2026-05-12T05:39:35.004741Z","end":"2026-05-12T05:39:35.301741Z","steps":["trace[398520417] 'agreement among raft nodes before linearized reading'  (duration: 296.706775ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.305783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.219094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-05-12T05:39:35.305838Z","caller":"traceutil/trace.go:171","msg":"trace[545266864] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:22; }","duration":"241.7631ms","start":"2026-05-12T05:39:35.064062Z","end":"2026-05-12T05:39:35.305825Z","steps":["trace[545266864] 'agreement among raft nodes before linearized reading'  (duration: 241.135773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.305952Z","caller":"traceutil/trace.go:171","msg":"trace[1594789167] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"239.868808ms","start":"2026-05-12T05:39:35.066059Z","end":"2026-05-12T05:39:35.305928Z","steps":["trace[1594789167] 'process raft request'  (duration: 239.056949ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.305985Z","caller":"traceutil/trace.go:171","msg":"trace[141452508] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"240.92993ms","start":"2026-05-12T05:39:35.064946Z","end":"2026-05-12T05:39:35.305876Z","steps":["trace[141452508] 'process raft request'  (duration: 239.195511ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:39:35.306054Z","caller":"traceutil/trace.go:171","msg":"trace[1517710936] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"239.885978ms","start":"2026-05-12T05:39:35.066158Z","end":"2026-05-12T05:39:35.306044Z","steps":["trace[1517710936] 'process raft request'  (duration: 238.992689ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.30613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.882077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-12T05:39:35.306186Z","caller":"traceutil/trace.go:171","msg":"trace[410055953] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:22; }","duration":"238.963908ms","start":"2026-05-12T05:39:35.067206Z","end":"2026-05-12T05:39:35.306169Z","steps":["trace[410055953] 'agreement among raft nodes before linearized reading'  (duration: 238.876267ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:39:35.306313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.578708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-12T05:39:35.306509Z","caller":"traceutil/trace.go:171","msg":"trace[1595144800] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:22; }","duration":"163.793641ms","start":"2026-05-12T05:39:35.142677Z","end":"2026-05-12T05:39:35.306471Z","steps":["trace[1595144800] 'agreement among raft nodes before linearized reading'  (duration: 163.565187ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:03.177322Z","caller":"traceutil/trace.go:171","msg":"trace[1838514062] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"179.072578ms","start":"2026-05-12T05:40:02.998224Z","end":"2026-05-12T05:40:03.177296Z","steps":["trace[1838514062] 'read index received'  (duration: 177.405684ms)","trace[1838514062] 'applied index is now lower than readState.Index'  (duration: 1.665734ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:03.177355Z","caller":"traceutil/trace.go:171","msg":"trace[212619892] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"182.444356ms","start":"2026-05-12T05:40:02.994885Z","end":"2026-05-12T05:40:03.177329Z","steps":["trace[212619892] 'process raft request'  (duration: 180.756272ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:03.177622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.37354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"}
{"level":"info","ts":"2026-05-12T05:40:03.177688Z","caller":"traceutil/trace.go:171","msg":"trace[1685071306] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:618; }","duration":"179.470721ms","start":"2026-05-12T05:40:02.998193Z","end":"2026-05-12T05:40:03.177663Z","steps":["trace[1685071306] 'agreement among raft nodes before linearized reading'  (duration: 179.205809ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:40:03.194215Z","caller":"traceutil/trace.go:171","msg":"trace[816156676] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"169.134689ms","start":"2026-05-12T05:40:03.025068Z","end":"2026-05-12T05:40:03.194203Z","steps":["trace[816156676] 'process raft request'  (duration: 168.128491ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:09.878799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.037165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-12T05:40:09.878982Z","caller":"traceutil/trace.go:171","msg":"trace[1206488501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"287.279696ms","start":"2026-05-12T05:40:09.591681Z","end":"2026-05-12T05:40:09.87896Z","steps":["trace[1206488501] 'range keys from in-memory index tree'  (duration: 286.847264ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:40:26.959491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.980962ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831755320194735 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:730 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:40:26.959632Z","caller":"traceutil/trace.go:171","msg":"trace[459724124] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"121.718634ms","start":"2026-05-12T05:40:26.837895Z","end":"2026-05-12T05:40:26.959614Z","steps":["trace[459724124] 'read index received'  (duration: 60.31µs)","trace[459724124] 'applied index is now lower than readState.Index'  (duration: 121.656564ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:40:26.959666Z","caller":"traceutil/trace.go:171","msg":"trace[1230459210] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"216.470328ms","start":"2026-05-12T05:40:26.743169Z","end":"2026-05-12T05:40:26.95964Z","steps":["trace[1230459210] 'process raft request'  (duration: 54.041562ms)","trace[1230459210] 'compare'  (duration: 161.715021ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:40:26.959721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.839814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:40:26.959749Z","caller":"traceutil/trace.go:171","msg":"trace[82265913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"121.916035ms","start":"2026-05-12T05:40:26.837824Z","end":"2026-05-12T05:40:26.95974Z","steps":["trace[82265913] 'agreement among raft nodes before linearized reading'  (duration: 121.858585ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:41:46.913369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.329391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-12T05:41:46.913467Z","caller":"traceutil/trace.go:171","msg":"trace[880018978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1867; }","duration":"239.489704ms","start":"2026-05-12T05:41:46.673958Z","end":"2026-05-12T05:41:46.913447Z","steps":["trace[880018978] 'range keys from in-memory index tree'  (duration: 239.120277ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:42:21.355545Z","caller":"traceutil/trace.go:171","msg":"trace[522104141] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"181.578876ms","start":"2026-05-12T05:42:21.173928Z","end":"2026-05-12T05:42:21.355507Z","steps":["trace[522104141] 'process raft request'  (duration: 144.026657ms)","trace[522104141] 'compare'  (duration: 37.341806ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:42:21.467785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.355311ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831755320197366 > lease_revoke:<id:50e09e1ab29a0028>","response":"size:28"}
{"level":"info","ts":"2026-05-12T05:42:21.467906Z","caller":"traceutil/trace.go:171","msg":"trace[1348743321] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2188; }","duration":"228.097115ms","start":"2026-05-12T05:42:21.23979Z","end":"2026-05-12T05:42:21.467888Z","steps":["trace[1348743321] 'read index received'  (duration: 78.264676ms)","trace[1348743321] 'applied index is now lower than readState.Index'  (duration: 149.831029ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:42:21.467986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.180986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:42:21.468029Z","caller":"traceutil/trace.go:171","msg":"trace[389846981] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2111; }","duration":"228.250506ms","start":"2026-05-12T05:42:21.239762Z","end":"2026-05-12T05:42:21.468013Z","steps":["trace[389846981] 'agreement among raft nodes before linearized reading'  (duration: 228.174585ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:42:21.619335Z","caller":"traceutil/trace.go:171","msg":"trace[99611228] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"143.062042ms","start":"2026-05-12T05:42:21.47625Z","end":"2026-05-12T05:42:21.619312Z","steps":["trace[99611228] 'process raft request'  (duration: 142.903779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:42:21.624937Z","caller":"traceutil/trace.go:171","msg":"trace[289333726] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2191; }","duration":"101.42643ms","start":"2026-05-12T05:42:21.523492Z","end":"2026-05-12T05:42:21.624918Z","steps":["trace[289333726] 'read index received'  (duration: 95.856152ms)","trace[289333726] 'applied index is now lower than readState.Index'  (duration: 5.565347ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:42:21.625137Z","caller":"traceutil/trace.go:171","msg":"trace[543196380] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"121.85635ms","start":"2026-05-12T05:42:21.503268Z","end":"2026-05-12T05:42:21.625124Z","steps":["trace[543196380] 'process raft request'  (duration: 121.557304ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:42:21.625434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.932578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-12T05:42:21.625472Z","caller":"traceutil/trace.go:171","msg":"trace[334794153] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2113; }","duration":"102.018909ms","start":"2026-05-12T05:42:21.523439Z","end":"2026-05-12T05:42:21.625458Z","steps":["trace[334794153] 'agreement among raft nodes before linearized reading'  (duration: 101.864056ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:43:26.082615Z","caller":"traceutil/trace.go:171","msg":"trace[1323279492] linearizableReadLoop","detail":"{readStateIndex:2655; appliedIndex:2655; }","duration":"154.999432ms","start":"2026-05-12T05:43:25.92756Z","end":"2026-05-12T05:43:26.08256Z","steps":["trace[1323279492] 'read index received'  (duration: 154.981182ms)","trace[1323279492] 'applied index is now lower than readState.Index'  (duration: 13.96µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:43:26.082868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.281786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"}
{"level":"info","ts":"2026-05-12T05:43:26.082817Z","caller":"traceutil/trace.go:171","msg":"trace[1027013361] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"156.357288ms","start":"2026-05-12T05:43:25.926203Z","end":"2026-05-12T05:43:26.08256Z","steps":["trace[1027013361] 'process raft request'  (duration: 156.180626ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:43:26.082928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.462833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-12T05:43:26.082943Z","caller":"traceutil/trace.go:171","msg":"trace[1952202303] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2562; }","duration":"155.418728ms","start":"2026-05-12T05:43:25.927503Z","end":"2026-05-12T05:43:26.082922Z","steps":["trace[1952202303] 'agreement among raft nodes before linearized reading'  (duration: 155.142175ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:43:26.082979Z","caller":"traceutil/trace.go:171","msg":"trace[1971539243] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2562; }","duration":"118.585244ms","start":"2026-05-12T05:43:25.96438Z","end":"2026-05-12T05:43:26.082966Z","steps":["trace[1971539243] 'agreement among raft nodes before linearized reading'  (duration: 118.421742ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:43:59.453548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.021818ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5827831755320198936 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2734 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-12T05:43:59.453687Z","caller":"traceutil/trace.go:171","msg":"trace[1419890149] linearizableReadLoop","detail":"{readStateIndex:2846; appliedIndex:2844; }","duration":"234.406329ms","start":"2026-05-12T05:43:59.219268Z","end":"2026-05-12T05:43:59.453674Z","steps":["trace[1419890149] 'read index received'  (duration: 107.22145ms)","trace[1419890149] 'applied index is now lower than readState.Index'  (duration: 127.183959ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-12T05:43:59.453837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.56554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18aebb17e86e9bd5\" ","response":"range_response_count:1 size:779"}
{"level":"info","ts":"2026-05-12T05:43:59.453872Z","caller":"traceutil/trace.go:171","msg":"trace[1360724889] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18aebb17e86e9bd5; range_end:; response_count:1; response_revision:2745; }","duration":"234.631841ms","start":"2026-05-12T05:43:59.219231Z","end":"2026-05-12T05:43:59.453863Z","steps":["trace[1360724889] 'agreement among raft nodes before linearized reading'  (duration: 234.483019ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:43:59.453998Z","caller":"traceutil/trace.go:171","msg":"trace[1056732916] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"343.945683ms","start":"2026-05-12T05:43:59.110012Z","end":"2026-05-12T05:43:59.453957Z","steps":["trace[1056732916] 'process raft request'  (duration: 216.45212ms)","trace[1056732916] 'compare'  (duration: 126.945487ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:43:59.454053Z","caller":"traceutil/trace.go:171","msg":"trace[799502817] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"343.81784ms","start":"2026-05-12T05:43:59.110221Z","end":"2026-05-12T05:43:59.454039Z","steps":["trace[799502817] 'process raft request'  (duration: 343.411637ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:43:59.455456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:43:59.110204Z","time spent":"345.197715ms","remote":"127.0.0.1:44986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2736 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-12T05:43:59.45581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:43:59.10998Z","time spent":"344.161794ms","remote":"127.0.0.1:44986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2734 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-12T05:47:39.16949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.598932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-12T05:47:39.169579Z","caller":"traceutil/trace.go:171","msg":"trace[1929391493] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4618; }","duration":"127.720105ms","start":"2026-05-12T05:47:39.041837Z","end":"2026-05-12T05:47:39.169557Z","steps":["trace[1929391493] 'range keys from in-memory index tree'  (duration: 127.470241ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:47:39.169917Z","caller":"traceutil/trace.go:171","msg":"trace[848678535] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"126.912413ms","start":"2026-05-12T05:47:39.042993Z","end":"2026-05-12T05:47:39.169905Z","steps":["trace[848678535] 'process raft request'  (duration: 125.359611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:47:39.320311Z","caller":"traceutil/trace.go:171","msg":"trace[1529217098] linearizableReadLoop","detail":"{readStateIndex:4794; appliedIndex:4792; }","duration":"255.486939ms","start":"2026-05-12T05:47:39.064802Z","end":"2026-05-12T05:47:39.320289Z","steps":["trace[1529217098] 'read index received'  (duration: 103.564532ms)","trace[1529217098] 'applied index is now lower than readState.Index'  (duration: 151.920977ms)"],"step_count":2}
{"level":"info","ts":"2026-05-12T05:47:39.320376Z","caller":"traceutil/trace.go:171","msg":"trace[565899734] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"268.255061ms","start":"2026-05-12T05:47:39.052078Z","end":"2026-05-12T05:47:39.320334Z","steps":["trace[565899734] 'process raft request'  (duration: 268.057248ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:47:39.3205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.671952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-12T05:47:39.320543Z","caller":"traceutil/trace.go:171","msg":"trace[910707734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4620; }","duration":"255.781644ms","start":"2026-05-12T05:47:39.064748Z","end":"2026-05-12T05:47:39.320529Z","steps":["trace[910707734] 'agreement among raft nodes before linearized reading'  (duration: 255.685322ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-12T05:47:39.32067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.933947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-fdff1760-1bbd-44d4-956a-8fdaa57fa8fe\" ","response":"range_response_count:1 size:1450"}
{"level":"info","ts":"2026-05-12T05:47:39.320751Z","caller":"traceutil/trace.go:171","msg":"trace[1170186711] range","detail":"{range_begin:/registry/persistentvolumes/pvc-fdff1760-1bbd-44d4-956a-8fdaa57fa8fe; range_end:; response_count:1; response_revision:4620; }","duration":"147.056039ms","start":"2026-05-12T05:47:39.17368Z","end":"2026-05-12T05:47:39.320736Z","steps":["trace[1170186711] 'agreement among raft nodes before linearized reading'  (duration: 146.855567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-12T05:49:33.305418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925}
{"level":"info","ts":"2026-05-12T05:49:33.401515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"94.832057ms","hash":4139966576,"current-db-size-bytes":53760000,"current-db-size":"54 MB","current-db-size-in-use-bytes":29335552,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-12T05:49:33.40161Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4139966576,"revision":2925,"compact-revision":-1}
{"level":"info","ts":"2026-05-12T05:54:33.311139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5648}
{"level":"info","ts":"2026-05-12T05:54:33.389524Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5648,"took":"76.916938ms","hash":2940356351,"current-db-size-bytes":53760000,"current-db-size":"54 MB","current-db-size-in-use-bytes":18247680,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-12T05:54:33.38963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2940356351,"revision":5648,"compact-revision":2925}