{"level":"warn","ts":"2026-04-20T10:14:16.096079Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T10:14:16.096193Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-04-20T10:14:16.096272Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-20T10:14:16.09629Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-04-20T10:14:16.096316Z","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-04-20T10:14:16.100193Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]}
{"level":"info","ts":"2026-04-20T10:14:16.10033Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-04-20T10:14:16.80897Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"708.378503ms"}
{"level":"info","ts":"2026-04-20T10:14:17.156775Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"}
{"level":"info","ts":"2026-04-20T10:14:17.156981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T10:14:17.157024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"}
{"level":"info","ts":"2026-04-20T10:14:17.157048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-20T10:14:17.157247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"}
{"level":"info","ts":"2026-04-20T10:14:17.157334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"warn","ts":"2026-04-20T10:14:17.15931Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T10:14:17.161508Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T10:14:17.163125Z","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-04-20T10:14:17.166317Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T10:14:17.166645Z","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-04-20T10:14:17.166754Z","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-04-20T10:14:17.166779Z","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-04-20T10:14:17.167414Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-20T10:14:17.168318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"}
{"level":"info","ts":"2026-04-20T10:14:17.170016Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]}
{"level":"info","ts":"2026-04-20T10:14:17.173559Z","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-04-20T10:14:17.173759Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-04-20T10:14:17.173819Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"}
{"level":"info","ts":"2026-04-20T10:14:17.174118Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T10:14:17.174167Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T10:14:17.358687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-20T10:14:17.358754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-20T10:14:17.358781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"}
{"level":"info","ts":"2026-04-20T10:14:17.358805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"}
{"level":"info","ts":"2026-04-20T10:14:17.358822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-04-20T10:14:17.358844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"}
{"level":"info","ts":"2026-04-20T10:14:17.358871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"}
{"level":"info","ts":"2026-04-20T10:14:17.359941Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T10:14:17.359949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T10:14:17.360004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T10:14:17.360344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T10:14:17.360467Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T10:14:17.36055Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T10:14:17.361897Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T10:14:17.362036Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T10:14:17.362084Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T10:14:17.36395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"}
{"level":"info","ts":"2026-04-20T10:14:17.364259Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-04-20T10:14:52.515397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.748512ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439309679 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:458 > 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-04-20T10:14:52.515809Z","caller":"traceutil/trace.go:171","msg":"trace[402324059] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"368.720829ms","start":"2026-04-20T10:14:52.147026Z","end":"2026-04-20T10:14:52.515747Z","steps":["trace[402324059] 'process raft request'  (duration: 175.750457ms)","trace[402324059] 'compare'  (duration: 191.630279ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:14:52.51606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:52.147002Z","time spent":"368.936004ms","remote":"127.0.0.1:52936","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:458 > 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":"info","ts":"2026-04-20T10:14:52.516159Z","caller":"traceutil/trace.go:171","msg":"trace[395691089] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:550; }","duration":"349.209496ms","start":"2026-04-20T10:14:52.166929Z","end":"2026-04-20T10:14:52.516139Z","steps":["trace[395691089] 'read index received'  (duration: 155.876035ms)","trace[395691089] 'applied index is now lower than readState.Index'  (duration: 193.332361ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:14:52.516483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.543744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"}
{"level":"info","ts":"2026-04-20T10:14:52.516525Z","caller":"traceutil/trace.go:171","msg":"trace[928284830] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:531; }","duration":"349.614686ms","start":"2026-04-20T10:14:52.166898Z","end":"2026-04-20T10:14:52.516513Z","steps":["trace[928284830] 'agreement among raft nodes before linearized reading'  (duration: 349.311569ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:52.516568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:52.166869Z","time spent":"349.685928ms","remote":"127.0.0.1:52706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":150518,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "}
{"level":"info","ts":"2026-04-20T10:14:52.516566Z","caller":"traceutil/trace.go:171","msg":"trace[332192428] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"358.999748ms","start":"2026-04-20T10:14:52.157549Z","end":"2026-04-20T10:14:52.516549Z","steps":["trace[332192428] 'process raft request'  (duration: 358.112536ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:52.516722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:52.157522Z","time spent":"359.125552ms","remote":"127.0.0.1:52706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" value_size:97554 >> failure:<>"}
{"level":"info","ts":"2026-04-20T10:14:58.448095Z","caller":"traceutil/trace.go:171","msg":"trace[1028905090] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"185.040806ms","start":"2026-04-20T10:14:58.263039Z","end":"2026-04-20T10:14:58.44808Z","steps":["trace[1028905090] 'process raft request'  (duration: 179.440517ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:14:58.447856Z","caller":"traceutil/trace.go:171","msg":"trace[142883324] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"116.931982ms","start":"2026-04-20T10:14:58.330842Z","end":"2026-04-20T10:14:58.447774Z","steps":["trace[142883324] 'read index received'  (duration: 110.940254ms)","trace[142883324] 'applied index is now lower than readState.Index'  (duration: 5.989798ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:14:58.448039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.181278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5sl85\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-04-20T10:14:58.448412Z","caller":"traceutil/trace.go:171","msg":"trace[929590190] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5sl85; range_end:; response_count:1; response_revision:585; }","duration":"117.578107ms","start":"2026-04-20T10:14:58.330777Z","end":"2026-04-20T10:14:58.448355Z","steps":["trace[929590190] 'agreement among raft nodes before linearized reading'  (duration: 117.101346ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:59.04408Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512946439309857,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T10:14:59.102976Z","caller":"traceutil/trace.go:171","msg":"trace[1714495828] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"634.40547ms","start":"2026-04-20T10:14:58.468523Z","end":"2026-04-20T10:14:59.102928Z","steps":["trace[1714495828] 'process raft request'  (duration: 627.473039ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:59.103198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:58.468497Z","time spent":"634.574693ms","remote":"127.0.0.1:52848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5sl85\" mod_revision:473 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5sl85\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5sl85\" > >"}
{"level":"info","ts":"2026-04-20T10:14:59.104033Z","caller":"traceutil/trace.go:171","msg":"trace[2139856057] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"561.004574ms","start":"2026-04-20T10:14:58.542993Z","end":"2026-04-20T10:14:59.103998Z","steps":["trace[2139856057] 'read index received'  (duration: 553.015187ms)","trace[2139856057] 'applied index is now lower than readState.Index'  (duration: 7.987987ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:14:59.10417Z","caller":"traceutil/trace.go:171","msg":"trace[817046549] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"592.632266ms","start":"2026-04-20T10:14:58.511527Z","end":"2026-04-20T10:14:59.104159Z","steps":["trace[817046549] 'process raft request'  (duration: 592.349069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:59.104282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:58.5115Z","time spent":"592.704498ms","remote":"127.0.0.1:53166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T10:14:59.104523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.533798ms","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-04-20T10:14:59.104565Z","caller":"traceutil/trace.go:171","msg":"trace[529718443] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"561.610069ms","start":"2026-04-20T10:14:58.542943Z","end":"2026-04-20T10:14:59.104553Z","steps":["trace[529718443] 'agreement among raft nodes before linearized reading'  (duration: 561.452125ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:59.104597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:58.542915Z","time spent":"561.675501ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T10:14:59.104785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.729596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:14:59.104819Z","caller":"traceutil/trace.go:171","msg":"trace[1914045589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"304.779617ms","start":"2026-04-20T10:14:58.800031Z","end":"2026-04-20T10:14:59.104811Z","steps":["trace[1914045589] 'agreement among raft nodes before linearized reading'  (duration: 304.732136ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:14:59.104872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:14:58.800017Z","time spent":"304.85035ms","remote":"127.0.0.1:52638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-20T10:15:13.105458Z","caller":"traceutil/trace.go:171","msg":"trace[1128909597] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"205.842521ms","start":"2026-04-20T10:15:12.899585Z","end":"2026-04-20T10:15:13.105428Z","steps":["trace[1128909597] 'process raft request'  (duration: 205.680077ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:15:13.370146Z","caller":"traceutil/trace.go:171","msg":"trace[902921675] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"100.264ms","start":"2026-04-20T10:15:13.269855Z","end":"2026-04-20T10:15:13.370119Z","steps":["trace[902921675] 'read index received'  (duration: 5.979308ms)","trace[902921675] 'applied index is now lower than readState.Index'  (duration: 94.283392ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:15:13.370163Z","caller":"traceutil/trace.go:171","msg":"trace[518261261] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"187.894546ms","start":"2026-04-20T10:15:13.182238Z","end":"2026-04-20T10:15:13.370132Z","steps":["trace[518261261] 'process raft request'  (duration: 93.759918ms)","trace[518261261] 'compare'  (duration: 93.930213ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:15:13.370344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.480185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-20T10:15:13.370374Z","caller":"traceutil/trace.go:171","msg":"trace[91299003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:743; }","duration":"100.562667ms","start":"2026-04-20T10:15:13.269803Z","end":"2026-04-20T10:15:13.370365Z","steps":["trace[91299003] 'agreement among raft nodes before linearized reading'  (duration: 100.419493ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:15:47.929624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.658533ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439310624 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:949 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T10:15:47.92974Z","caller":"traceutil/trace.go:171","msg":"trace[1804623957] linearizableReadLoop","detail":"{readStateIndex:995; appliedIndex:994; }","duration":"275.58567ms","start":"2026-04-20T10:15:47.654137Z","end":"2026-04-20T10:15:47.929723Z","steps":["trace[1804623957] 'read index received'  (duration: 159.693682ms)","trace[1804623957] 'applied index is now lower than readState.Index'  (duration: 115.890908ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:15:47.929824Z","caller":"traceutil/trace.go:171","msg":"trace[425771543] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"288.62226ms","start":"2026-04-20T10:15:47.641191Z","end":"2026-04-20T10:15:47.929813Z","steps":["trace[425771543] 'process raft request'  (duration: 172.661329ms)","trace[425771543] 'compare'  (duration: 115.278354ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:15:47.930061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.092132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T10:15:47.930086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.957929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-20T10:15:47.930108Z","caller":"traceutil/trace.go:171","msg":"trace[127787286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"129.170014ms","start":"2026-04-20T10:15:47.800926Z","end":"2026-04-20T10:15:47.930096Z","steps":["trace[127787286] 'agreement among raft nodes before linearized reading'  (duration: 129.107772ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:15:47.930115Z","caller":"traceutil/trace.go:171","msg":"trace[334322352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:959; }","duration":"276.022691ms","start":"2026-04-20T10:15:47.654084Z","end":"2026-04-20T10:15:47.930106Z","steps":["trace[334322352] 'agreement among raft nodes before linearized reading'  (duration: 275.894608ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:15:48.268246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.018766ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439310628 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T10:15:48.268359Z","caller":"traceutil/trace.go:171","msg":"trace[141678831] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:995; }","duration":"109.730268ms","start":"2026-04-20T10:15:48.158612Z","end":"2026-04-20T10:15:48.268342Z","steps":["trace[141678831] 'read index received'  (duration: 45.941µs)","trace[141678831] 'applied index is now lower than readState.Index'  (duration: 109.682747ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:15:48.268416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.807319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:15:48.268433Z","caller":"traceutil/trace.go:171","msg":"trace[199201407] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:960; }","duration":"109.862481ms","start":"2026-04-20T10:15:48.158564Z","end":"2026-04-20T10:15:48.268427Z","steps":["trace[199201407] 'agreement among raft nodes before linearized reading'  (duration: 109.81983ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:15:48.26849Z","caller":"traceutil/trace.go:171","msg":"trace[1577576458] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"334.486463ms","start":"2026-04-20T10:15:47.933986Z","end":"2026-04-20T10:15:48.268472Z","steps":["trace[1577576458] 'process raft request'  (duration: 137.143639ms)","trace[1577576458] 'compare'  (duration: 196.883363ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:15:48.268567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:15:47.933965Z","time spent":"334.562105ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-20T10:16:12.257244Z","caller":"traceutil/trace.go:171","msg":"trace[1649122853] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"482.697913ms","start":"2026-04-20T10:16:11.7745Z","end":"2026-04-20T10:16:12.257198Z","steps":["trace[1649122853] 'read index received'  (duration: 474.647306ms)","trace[1649122853] 'applied index is now lower than readState.Index'  (duration: 8.049497ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:12.257555Z","caller":"traceutil/trace.go:171","msg":"trace[53382824] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"484.951188ms","start":"2026-04-20T10:16:11.772569Z","end":"2026-04-20T10:16:12.25752Z","steps":["trace[53382824] 'process raft request'  (duration: 476.567763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:12.257645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.117553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-04-20T10:16:12.25772Z","caller":"traceutil/trace.go:171","msg":"trace[960806728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"483.238446ms","start":"2026-04-20T10:16:11.774464Z","end":"2026-04-20T10:16:12.257703Z","steps":["trace[960806728] 'agreement among raft nodes before linearized reading'  (duration: 483.000021ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:12.257705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:11.772543Z","time spent":"485.077411ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1029 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-20T10:16:12.257774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:11.774452Z","time spent":"483.308478ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-20T10:16:12.301274Z","caller":"traceutil/trace.go:171","msg":"trace[1116535729] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"517.726982ms","start":"2026-04-20T10:16:11.783511Z","end":"2026-04-20T10:16:12.301238Z","steps":["trace[1116535729] 'process raft request'  (duration: 517.429014ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:12.301454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:11.783484Z","time spent":"517.875275ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1002 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-04-20T10:16:12.301878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.697169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:12.302052Z","caller":"traceutil/trace.go:171","msg":"trace[1581655203] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"232.168457ms","start":"2026-04-20T10:16:12.069849Z","end":"2026-04-20T10:16:12.302017Z","steps":["trace[1581655203] 'process raft request'  (duration: 231.316956ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:16:12.301952Z","caller":"traceutil/trace.go:171","msg":"trace[247122741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1038; }","duration":"501.804161ms","start":"2026-04-20T10:16:11.800131Z","end":"2026-04-20T10:16:12.301936Z","steps":["trace[247122741] 'agreement among raft nodes before linearized reading'  (duration: 501.679878ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:12.30304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:11.800111Z","time spent":"502.734714ms","remote":"127.0.0.1:52638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-20T10:16:13.961359Z","caller":"traceutil/trace.go:171","msg":"trace[879028687] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1082; }","duration":"161.127967ms","start":"2026-04-20T10:16:13.800203Z","end":"2026-04-20T10:16:13.961331Z","steps":["trace[879028687] 'read index received'  (duration: 161.086186ms)","trace[879028687] 'applied index is now lower than readState.Index'  (duration: 40.671µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:13.961434Z","caller":"traceutil/trace.go:171","msg":"trace[852946405] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"181.633889ms","start":"2026-04-20T10:16:13.779768Z","end":"2026-04-20T10:16:13.961402Z","steps":["trace[852946405] 'process raft request'  (duration: 181.432224ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:13.961506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.28217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:13.961798Z","caller":"traceutil/trace.go:171","msg":"trace[663282969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1042; }","duration":"161.633639ms","start":"2026-04-20T10:16:13.80014Z","end":"2026-04-20T10:16:13.961774Z","steps":["trace[663282969] 'agreement among raft nodes before linearized reading'  (duration: 161.303511ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:16:14.188285Z","caller":"traceutil/trace.go:171","msg":"trace[2018408769] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"135.092829ms","start":"2026-04-20T10:16:14.053166Z","end":"2026-04-20T10:16:14.188258Z","steps":["trace[2018408769] 'read index received'  (duration: 108.452927ms)","trace[2018408769] 'applied index is now lower than readState.Index'  (duration: 26.638812ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:14.188369Z","caller":"traceutil/trace.go:171","msg":"trace[782898901] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"382.192331ms","start":"2026-04-20T10:16:13.806144Z","end":"2026-04-20T10:16:14.188336Z","steps":["trace[782898901] 'process raft request'  (duration: 355.541928ms)","trace[782898901] 'compare'  (duration: 26.370776ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:16:14.18852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:13.806107Z","time spent":"382.332645ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1012 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-20T10:16:14.188568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.291733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:14.188711Z","caller":"traceutil/trace.go:171","msg":"trace[2131827781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1043; }","duration":"135.56867ms","start":"2026-04-20T10:16:14.053098Z","end":"2026-04-20T10:16:14.188666Z","steps":["trace[2131827781] 'agreement among raft nodes before linearized reading'  (duration: 135.268063ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:27.044331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.086855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:27.044419Z","caller":"traceutil/trace.go:171","msg":"trace[664051426] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1136; }","duration":"350.232239ms","start":"2026-04-20T10:16:26.694169Z","end":"2026-04-20T10:16:27.044401Z","steps":["trace[664051426] 'count revisions from in-memory index tree'  (duration: 349.991963ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:27.044461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:26.69415Z","time spent":"350.30202ms","remote":"127.0.0.1:52818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T10:16:27.044583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.460252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:27.044661Z","caller":"traceutil/trace.go:171","msg":"trace[836468149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1136; }","duration":"156.630747ms","start":"2026-04-20T10:16:26.888012Z","end":"2026-04-20T10:16:27.044643Z","steps":["trace[836468149] 'count revisions from in-memory index tree'  (duration: 156.354869ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:27.044734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.309456ms","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":"warn","ts":"2026-04-20T10:16:27.044762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.900375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-20T10:16:27.044812Z","caller":"traceutil/trace.go:171","msg":"trace[1653672827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1136; }","duration":"309.447909ms","start":"2026-04-20T10:16:26.735347Z","end":"2026-04-20T10:16:27.044795Z","steps":["trace[1653672827] 'range keys from in-memory index tree'  (duration: 309.135031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:16:27.044856Z","caller":"traceutil/trace.go:171","msg":"trace[897146972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1136; }","duration":"547.005598ms","start":"2026-04-20T10:16:26.497805Z","end":"2026-04-20T10:16:27.044811Z","steps":["trace[897146972] 'range keys from in-memory index tree'  (duration: 546.66599ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:27.044884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:26.735322Z","time spent":"309.554802ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-20T10:16:27.04489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:26.497779Z","time spent":"547.103731ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-20T10:16:44.5463Z","caller":"traceutil/trace.go:171","msg":"trace[676350244] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"113.049335ms","start":"2026-04-20T10:16:44.43322Z","end":"2026-04-20T10:16:44.546269Z","steps":["trace[676350244] 'process raft request'  (duration: 112.539663ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:44.939449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.616463ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439311242 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1161 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T10:16:44.939653Z","caller":"traceutil/trace.go:171","msg":"trace[934003319] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"388.146049ms","start":"2026-04-20T10:16:44.551485Z","end":"2026-04-20T10:16:44.939631Z","steps":["trace[934003319] 'process raft request'  (duration: 388.085828ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:44.939738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:44.551461Z","time spent":"388.243711ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1207 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-20T10:16:44.939717Z","caller":"traceutil/trace.go:171","msg":"trace[1131497585] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"479.730028ms","start":"2026-04-20T10:16:44.459958Z","end":"2026-04-20T10:16:44.939688Z","steps":["trace[1131497585] 'process raft request'  (duration: 173.768776ms)","trace[1131497585] 'compare'  (duration: 305.48179ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:16:44.939873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:44.459939Z","time spent":"479.85278ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1161 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-20T10:16:44.939697Z","caller":"traceutil/trace.go:171","msg":"trace[1823780880] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"393.699136ms","start":"2026-04-20T10:16:44.545961Z","end":"2026-04-20T10:16:44.93966Z","steps":["trace[1823780880] 'read index received'  (duration: 87.868978ms)","trace[1823780880] 'applied index is now lower than readState.Index'  (duration: 305.825128ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:16:44.940022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.200729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-20T10:16:44.940076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.978567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:44.940108Z","caller":"traceutil/trace.go:171","msg":"trace[617854856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1222; }","duration":"447.310351ms","start":"2026-04-20T10:16:44.492761Z","end":"2026-04-20T10:16:44.940071Z","steps":["trace[617854856] 'agreement among raft nodes before linearized reading'  (duration: 447.015804ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:16:44.940146Z","caller":"traceutil/trace.go:171","msg":"trace[320952019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"138.120251ms","start":"2026-04-20T10:16:44.802011Z","end":"2026-04-20T10:16:44.940131Z","steps":["trace[320952019] 'agreement among raft nodes before linearized reading'  (duration: 137.993817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:44.940154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:44.492743Z","time spent":"447.400994ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T10:16:45.569493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.256396ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439311260 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1230 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T10:16:45.56964Z","caller":"traceutil/trace.go:171","msg":"trace[38271230] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"196.998336ms","start":"2026-04-20T10:16:45.372619Z","end":"2026-04-20T10:16:45.569617Z","steps":["trace[38271230] 'process raft request'  (duration: 95.493865ms)","trace[38271230] 'compare'  (duration: 101.108642ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:45.577346Z","caller":"traceutil/trace.go:171","msg":"trace[127677129] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1279; }","duration":"136.781618ms","start":"2026-04-20T10:16:45.440549Z","end":"2026-04-20T10:16:45.577331Z","steps":["trace[127677129] 'read index received'  (duration: 27.568957ms)","trace[127677129] 'applied index is now lower than readState.Index'  (duration: 109.211541ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:45.577412Z","caller":"traceutil/trace.go:171","msg":"trace[1249855425] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"204.578753ms","start":"2026-04-20T10:16:45.372791Z","end":"2026-04-20T10:16:45.577369Z","steps":["trace[1249855425] 'process raft request'  (duration: 204.47034ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:45.577486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.938492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T10:16:45.577513Z","caller":"traceutil/trace.go:171","msg":"trace[152782992] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1232; }","duration":"137.018754ms","start":"2026-04-20T10:16:45.440485Z","end":"2026-04-20T10:16:45.577504Z","steps":["trace[152782992] 'agreement among raft nodes before linearized reading'  (duration: 136.920561ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:57.902487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.834816ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1011512946439311420 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1299 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T10:16:57.9026Z","caller":"traceutil/trace.go:171","msg":"trace[573923155] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1359; }","duration":"488.347878ms","start":"2026-04-20T10:16:57.414235Z","end":"2026-04-20T10:16:57.902583Z","steps":["trace[573923155] 'read index received'  (duration: 47.891µs)","trace[573923155] 'applied index is now lower than readState.Index'  (duration: 488.299007ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:16:57.902746Z","caller":"traceutil/trace.go:171","msg":"trace[1218446928] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"606.759176ms","start":"2026-04-20T10:16:57.295956Z","end":"2026-04-20T10:16:57.902715Z","steps":["trace[1218446928] 'process raft request'  (duration: 52.597221ms)","trace[1218446928] 'compare'  (duration: 553.496088ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T10:16:57.902929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:57.295943Z","time spent":"606.89114ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1299 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-20T10:16:57.903014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.77905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"warn","ts":"2026-04-20T10:16:57.903071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.656361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T10:16:57.903098Z","caller":"traceutil/trace.go:171","msg":"trace[984415046] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1308; }","duration":"488.910583ms","start":"2026-04-20T10:16:57.414168Z","end":"2026-04-20T10:16:57.903078Z","steps":["trace[984415046] 'agreement among raft nodes before linearized reading'  (duration: 488.490222ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:16:57.903115Z","caller":"traceutil/trace.go:171","msg":"trace[662533947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"100.756473ms","start":"2026-04-20T10:16:57.802345Z","end":"2026-04-20T10:16:57.903102Z","steps":["trace[662533947] 'agreement among raft nodes before linearized reading'  (duration: 100.676511ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:16:57.90317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T10:16:57.414141Z","time spent":"489.017106ms","remote":"127.0.0.1:52936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-04-20T10:16:58.450703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.688121ms","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-04-20T10:16:58.450806Z","caller":"traceutil/trace.go:171","msg":"trace[184913203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1310; }","duration":"113.849005ms","start":"2026-04-20T10:16:58.336934Z","end":"2026-04-20T10:16:58.450783Z","steps":["trace[184913203] 'range keys from in-memory index tree'  (duration: 113.462246ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:20:18.745845Z","caller":"traceutil/trace.go:171","msg":"trace[468910725] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2350; }","duration":"266.273123ms","start":"2026-04-20T10:20:18.479545Z","end":"2026-04-20T10:20:18.745818Z","steps":["trace[468910725] 'read index received'  (duration: 266.058908ms)","trace[468910725] 'applied index is now lower than readState.Index'  (duration: 211.005µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:20:18.745989Z","caller":"traceutil/trace.go:171","msg":"trace[645787057] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"292.651631ms","start":"2026-04-20T10:20:18.453298Z","end":"2026-04-20T10:20:18.74595Z","steps":["trace[645787057] 'process raft request'  (duration: 292.381124ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:20:18.747732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.174788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-04-20T10:20:18.748968Z","caller":"traceutil/trace.go:171","msg":"trace[142879307] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2258; }","duration":"269.427358ms","start":"2026-04-20T10:20:18.479491Z","end":"2026-04-20T10:20:18.748919Z","steps":["trace[142879307] 'agreement among raft nodes before linearized reading'  (duration: 266.482268ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T10:20:34.3464Z","caller":"traceutil/trace.go:171","msg":"trace[295571582] linearizableReadLoop","detail":"{readStateIndex:2435; appliedIndex:2433; }","duration":"136.6502ms","start":"2026-04-20T10:20:34.209726Z","end":"2026-04-20T10:20:34.346376Z","steps":["trace[295571582] 'read index received'  (duration: 50.811429ms)","trace[295571582] 'applied index is now lower than readState.Index'  (duration: 85.837861ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T10:20:34.346489Z","caller":"traceutil/trace.go:171","msg":"trace[1254042134] transaction","detail":"{read_only:false; response_revision:2338; number_of_response:1; }","duration":"146.023333ms","start":"2026-04-20T10:20:34.200436Z","end":"2026-04-20T10:20:34.346459Z","steps":["trace[1254042134] 'process raft request'  (duration: 144.6602ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T10:20:34.346574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.826904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" ","response":"range_response_count:1 size:731"}
{"level":"info","ts":"2026-04-20T10:20:34.346771Z","caller":"traceutil/trace.go:171","msg":"trace[166592985] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ttl-controller; range_end:; response_count:1; response_revision:2338; }","duration":"137.039058ms","start":"2026-04-20T10:20:34.209696Z","end":"2026-04-20T10:20:34.346735Z","steps":["trace[166592985] 'agreement among raft nodes before linearized reading'  (duration: 136.816163ms)"],"step_count":1}