{"level":"warn","ts":"2026-09-16T21:43:19.161953Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-16T21:43:19.162056Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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://162.253.55.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-09-16T21:43:19.162268Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-16T21:43:19.162286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-09-16T21:43:19.162403Z","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-09-16T21:43:19.163157Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]}
{"level":"info","ts":"2026-09-16T21:43:19.163283Z","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://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-09-16T21:43:19.173241Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.6817ms"}
{"level":"info","ts":"2026-09-16T21:43:19.192254Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"}
{"level":"info","ts":"2026-09-16T21:43:19.192353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-16T21:43:19.192373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"}
{"level":"info","ts":"2026-09-16T21:43:19.192388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-16T21:43:19.192395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"}
{"level":"info","ts":"2026-09-16T21:43:19.19243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"warn","ts":"2026-09-16T21:43:19.21131Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-16T21:43:19.215162Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-16T21:43:19.219398Z","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-09-16T21:43:19.223623Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-16T21:43:19.223903Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-16T21:43:19.224045Z","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-09-16T21:43:19.224155Z","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-09-16T21:43:19.224167Z","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-09-16T21:43:19.226428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"info","ts":"2026-09-16T21:43:19.226566Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-09-16T21:43:19.227672Z","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-09-16T21:43:19.227805Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-09-16T21:43:19.22786Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-09-16T21:43:19.228534Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-16T21:43:19.22859Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-16T21:43:19.793212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-16T21:43:19.793266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-16T21:43:19.793287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"}
{"level":"info","ts":"2026-09-16T21:43:19.793322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"}
{"level":"info","ts":"2026-09-16T21:43:19.793332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-09-16T21:43:19.793345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"}
{"level":"info","ts":"2026-09-16T21:43:19.793358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-09-16T21:43:19.794446Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-16T21:43:19.797003Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-16T21:43:19.797086Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-16T21:43:19.797104Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-16T21:43:19.797129Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-16T21:43:19.797148Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-16T21:43:19.797506Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-16T21:43:19.798536Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-16T21:43:19.798605Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-16T21:43:19.800601Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"}
{"level":"info","ts":"2026-09-16T21:43:19.800713Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-09-16T21:43:24.25522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239209411s","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862362474 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:controller:daemon-set-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:controller:daemon-set-controller\" value_size:875 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-16T21:43:24.2556Z","caller":"traceutil/trace.go:171","msg":"trace[1693819117] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"979.410233ms","start":"2026-09-16T21:43:23.276149Z","end":"2026-09-16T21:43:24.255559Z","steps":["trace[1693819117] 'process raft request'  (duration: 979.324759ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:24.255633Z","caller":"traceutil/trace.go:171","msg":"trace[1505934651] linearizableReadLoop","detail":"{readStateIndex:158; appliedIndex:157; }","duration":"1.063130511s","start":"2026-09-16T21:43:23.192485Z","end":"2026-09-16T21:43:24.255615Z","steps":["trace[1505934651] 'read index received'  (duration: 32.412µs)","trace[1505934651] 'applied index is now lower than readState.Index'  (duration: 1.063096219s)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:24.255781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:23.276126Z","time spent":"979.605244ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-09-16T21:43:24.256043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063461038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:43:24.256233Z","caller":"traceutil/trace.go:171","msg":"trace[1761595792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:154; }","duration":"1.063736144s","start":"2026-09-16T21:43:23.192444Z","end":"2026-09-16T21:43:24.25618Z","steps":["trace[1761595792] 'agreement among raft nodes before linearized reading'  (duration: 1.063263778s)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:24.256319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.61852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-16T21:43:24.256398Z","caller":"traceutil/trace.go:171","msg":"trace[2049876937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:154; }","duration":"907.750807ms","start":"2026-09-16T21:43:23.348628Z","end":"2026-09-16T21:43:24.256379Z","steps":["trace[2049876937] 'agreement among raft nodes before linearized reading'  (duration: 907.572448ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:24.256445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:23.348603Z","time spent":"907.833231ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-16T21:43:24.255556Z","caller":"traceutil/trace.go:171","msg":"trace[1195203096] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"1.670708043s","start":"2026-09-16T21:43:22.584767Z","end":"2026-09-16T21:43:24.255475Z","steps":["trace[1195203096] 'process raft request'  (duration: 430.689627ms)","trace[1195203096] 'compare'  (duration: 1.239057283s)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:24.256623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:22.58475Z","time spent":"1.671794762s","remote":"127.0.0.1:46526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":945,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:controller:daemon-set-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:controller:daemon-set-controller\" value_size:875 >> failure:<>"}
{"level":"warn","ts":"2026-09-16T21:43:24.256758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.151459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-16T21:43:24.256804Z","caller":"traceutil/trace.go:171","msg":"trace[78306590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:154; }","duration":"908.239073ms","start":"2026-09-16T21:43:23.348554Z","end":"2026-09-16T21:43:24.256793Z","steps":["trace[78306590] 'agreement among raft nodes before linearized reading'  (duration: 907.61019ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:24.256829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:23.348535Z","time spent":"908.287736ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-16T21:43:24.256341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:23.192427Z","time spent":"1.063896523s","remote":"127.0.0.1:46202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-16T21:43:24.792979Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430393107862362479,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-09-16T21:43:25.201666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.285824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862362480 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:43 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-16T21:43:25.201768Z","caller":"traceutil/trace.go:171","msg":"trace[793769204] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"939.51261ms","start":"2026-09-16T21:43:24.262238Z","end":"2026-09-16T21:43:25.20175Z","steps":["trace[793769204] 'process raft request'  (duration: 830.926699ms)","trace[793769204] 'compare'  (duration: 108.146257ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:25.201824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:24.262219Z","time spent":"939.577083ms","remote":"127.0.0.1:46446","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:43 > 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-09-16T21:43:25.23014Z","caller":"traceutil/trace.go:171","msg":"trace[134604543] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"967.67182ms","start":"2026-09-16T21:43:24.262433Z","end":"2026-09-16T21:43:25.230105Z","steps":["trace[134604543] 'process raft request'  (duration: 966.710748ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:25.230273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:24.262409Z","time spent":"967.808707ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:42 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-16T21:43:25.231148Z","caller":"traceutil/trace.go:171","msg":"trace[1999505005] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"967.444168ms","start":"2026-09-16T21:43:24.263685Z","end":"2026-09-16T21:43:25.231129Z","steps":["trace[1999505005] 'process raft request'  (duration: 965.615109ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:25.231325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:24.263669Z","time spent":"967.523693ms","remote":"127.0.0.1:46526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":900,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:controller:deployment-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:controller:deployment-controller\" value_size:830 >> failure:<>"}
{"level":"info","ts":"2026-09-16T21:43:25.231518Z","caller":"traceutil/trace.go:171","msg":"trace[892531197] linearizableReadLoop","detail":"{readStateIndex:163; appliedIndex:159; }","duration":"939.532679ms","start":"2026-09-16T21:43:24.291863Z","end":"2026-09-16T21:43:25.231396Z","steps":["trace[892531197] 'read index received'  (duration: 801.321358ms)","trace[892531197] 'applied index is now lower than readState.Index'  (duration: 138.067173ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:43:25.232265Z","caller":"traceutil/trace.go:171","msg":"trace[462271283] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"792.387119ms","start":"2026-09-16T21:43:24.439827Z","end":"2026-09-16T21:43:25.232214Z","steps":["trace[462271283] 'process raft request'  (duration: 791.223786ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:25.232801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:24.439798Z","time spent":"792.922748ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-09-16T21:43:25.235691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.821891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:43:25.235765Z","caller":"traceutil/trace.go:171","msg":"trace[1605639721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:158; }","duration":"943.922267ms","start":"2026-09-16T21:43:24.291824Z","end":"2026-09-16T21:43:25.235747Z","steps":["trace[1605639721] 'agreement among raft nodes before linearized reading'  (duration: 939.909479ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:25.235797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:24.29181Z","time spent":"943.97858ms","remote":"127.0.0.1:46202","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-09-16T21:43:25.490049Z","caller":"traceutil/trace.go:171","msg":"trace[1885905998] linearizableReadLoop","detail":"{readStateIndex:165; appliedIndex:164; }","duration":"197.576656ms","start":"2026-09-16T21:43:25.292441Z","end":"2026-09-16T21:43:25.490018Z","steps":["trace[1885905998] 'read index received'  (duration: 188.194716ms)","trace[1885905998] 'applied index is now lower than readState.Index'  (duration: 9.38072ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:43:25.490431Z","caller":"traceutil/trace.go:171","msg":"trace[1485217519] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"240.014212ms","start":"2026-09-16T21:43:25.250395Z","end":"2026-09-16T21:43:25.490409Z","steps":["trace[1485217519] 'process raft request'  (duration: 230.335506ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:25.490585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.135686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:43:25.49064Z","caller":"traceutil/trace.go:171","msg":"trace[119662084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"198.243331ms","start":"2026-09-16T21:43:25.292382Z","end":"2026-09-16T21:43:25.490625Z","steps":["trace[119662084] 'agreement among raft nodes before linearized reading'  (duration: 197.733184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:32.98153Z","caller":"traceutil/trace.go:171","msg":"trace[1941353277] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"101.16106ms","start":"2026-09-16T21:43:32.880291Z","end":"2026-09-16T21:43:32.981452Z","steps":["trace[1941353277] 'process raft request'  (duration: 91.954876ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:33.022568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.118192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-09-16T21:43:33.022658Z","caller":"traceutil/trace.go:171","msg":"trace[703025347] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:365; }","duration":"108.25409ms","start":"2026-09-16T21:43:32.914381Z","end":"2026-09-16T21:43:33.022635Z","steps":["trace[703025347] 'agreement among raft nodes before linearized reading'  (duration: 60.255106ms)","trace[703025347] 'range keys from in-memory index tree'  (duration: 47.494267ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:43:33.238647Z","caller":"traceutil/trace.go:171","msg":"trace[321728557] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"175.639994ms","start":"2026-09-16T21:43:33.062976Z","end":"2026-09-16T21:43:33.238616Z","steps":["trace[321728557] 'process raft request'  (duration: 93.263107ms)","trace[321728557] 'compare'  (duration: 82.045149ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:43:33.238803Z","caller":"traceutil/trace.go:171","msg":"trace[1397973190] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"173.625271ms","start":"2026-09-16T21:43:33.065153Z","end":"2026-09-16T21:43:33.238779Z","steps":["trace[1397973190] 'process raft request'  (duration: 173.360747ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:33.238853Z","caller":"traceutil/trace.go:171","msg":"trace[1178939324] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"138.974458ms","start":"2026-09-16T21:43:33.099862Z","end":"2026-09-16T21:43:33.238837Z","steps":["trace[1178939324] 'process raft request'  (duration: 138.728165ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:33.23892Z","caller":"traceutil/trace.go:171","msg":"trace[1494649736] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:385; }","duration":"141.968056ms","start":"2026-09-16T21:43:33.096942Z","end":"2026-09-16T21:43:33.23891Z","steps":["trace[1494649736] 'read index received'  (duration: 59.309024ms)","trace[1494649736] 'applied index is now lower than readState.Index'  (duration: 82.658152ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:33.239063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.298082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"}
{"level":"info","ts":"2026-09-16T21:43:33.239094Z","caller":"traceutil/trace.go:171","msg":"trace[452830169] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:376; }","duration":"148.368845ms","start":"2026-09-16T21:43:33.090717Z","end":"2026-09-16T21:43:33.239086Z","steps":["trace[452830169] 'agreement among raft nodes before linearized reading'  (duration: 148.252569ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:33.239063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.869591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-09-16T21:43:33.23917Z","caller":"traceutil/trace.go:171","msg":"trace[583840880] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:376; }","duration":"127.006248ms","start":"2026-09-16T21:43:33.112155Z","end":"2026-09-16T21:43:33.239161Z","steps":["trace[583840880] 'agreement among raft nodes before linearized reading'  (duration: 126.881151ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:33.567695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.301493ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862362965 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-mf42x.18d5eb2ed04c0fd9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-mf42x.18d5eb2ed04c0fd9\" value_size:674 lease:3207021071007586505 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-16T21:43:33.567935Z","caller":"traceutil/trace.go:171","msg":"trace[1647392396] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"320.492792ms","start":"2026-09-16T21:43:33.24743Z","end":"2026-09-16T21:43:33.567923Z","steps":["trace[1647392396] 'process raft request'  (duration: 199.905044ms)","trace[1647392396] 'compare'  (duration: 120.153954ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:33.567999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:33.247407Z","time spent":"320.566667ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-mf42x.18d5eb2ed04c0fd9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-mf42x.18d5eb2ed04c0fd9\" value_size:674 lease:3207021071007586505 >> failure:<>"}
{"level":"info","ts":"2026-09-16T21:43:33.567929Z","caller":"traceutil/trace.go:171","msg":"trace[1242774032] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"320.191345ms","start":"2026-09-16T21:43:33.247717Z","end":"2026-09-16T21:43:33.567908Z","steps":["trace[1242774032] 'process raft request'  (duration: 320.068198ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:33.568091Z","caller":"traceutil/trace.go:171","msg":"trace[69352919] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:389; }","duration":"239.036677ms","start":"2026-09-16T21:43:33.328975Z","end":"2026-09-16T21:43:33.568011Z","steps":["trace[69352919] 'read index received'  (duration: 118.371964ms)","trace[69352919] 'applied index is now lower than readState.Index'  (duration: 120.659162ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:43:33.568244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.8256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-16T21:43:33.568271Z","caller":"traceutil/trace.go:171","msg":"trace[912466689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:380; }","duration":"295.863072ms","start":"2026-09-16T21:43:33.272401Z","end":"2026-09-16T21:43:33.568264Z","steps":["trace[912466689] 'agreement among raft nodes before linearized reading'  (duration: 295.733705ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:33.568381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.37666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"}
{"level":"info","ts":"2026-09-16T21:43:33.568445Z","caller":"traceutil/trace.go:171","msg":"trace[1547999791] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"233.994374ms","start":"2026-09-16T21:43:33.333889Z","end":"2026-09-16T21:43:33.567883Z","steps":["trace[1547999791] 'process raft request'  (duration: 233.950981ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:43:33.56846Z","caller":"traceutil/trace.go:171","msg":"trace[591017875] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:380; }","duration":"319.504267ms","start":"2026-09-16T21:43:33.248941Z","end":"2026-09-16T21:43:33.568445Z","steps":["trace[591017875] 'agreement among raft nodes before linearized reading'  (duration: 319.303936ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:43:33.56855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:33.248926Z","time spent":"319.610943ms","remote":"127.0.0.1:46630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3729,"request content":"key:\"/registry/deployments/kube-system/coredns\" "}
{"level":"warn","ts":"2026-09-16T21:43:33.569281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:43:33.24771Z","time spent":"320.478782ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-jr5np\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-jr5np\" value_size:3468 >> failure:<>"}
{"level":"info","ts":"2026-09-16T21:43:56.466281Z","caller":"traceutil/trace.go:171","msg":"trace[1345533681] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"109.349041ms","start":"2026-09-16T21:43:56.356905Z","end":"2026-09-16T21:43:56.466254Z","steps":["trace[1345533681] 'process raft request'  (duration: 107.130281ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.290956Z","caller":"traceutil/trace.go:171","msg":"trace[1744151812] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"173.548205ms","start":"2026-09-16T21:44:08.117394Z","end":"2026-09-16T21:44:08.290942Z","steps":["trace[1744151812] 'process raft request'  (duration: 91.817061ms)","trace[1744151812] 'compare'  (duration: 81.674364ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:44:08.40484Z","caller":"traceutil/trace.go:171","msg":"trace[559540359] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"283.228785ms","start":"2026-09-16T21:44:08.121575Z","end":"2026-09-16T21:44:08.404804Z","steps":["trace[559540359] 'process raft request'  (duration: 281.533836ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.404937Z","caller":"traceutil/trace.go:171","msg":"trace[909759395] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"281.617327ms","start":"2026-09-16T21:44:08.123294Z","end":"2026-09-16T21:44:08.404912Z","steps":["trace[909759395] 'process raft request'  (duration: 281.388935ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.404916Z","caller":"traceutil/trace.go:171","msg":"trace[650908010] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"258.215536ms","start":"2026-09-16T21:44:08.146682Z","end":"2026-09-16T21:44:08.404897Z","steps":["trace[650908010] 'process raft request'  (duration: 258.141086ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.404976Z","caller":"traceutil/trace.go:171","msg":"trace[1580255547] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"276.850679ms","start":"2026-09-16T21:44:08.12811Z","end":"2026-09-16T21:44:08.404961Z","steps":["trace[1580255547] 'process raft request'  (duration: 276.628708ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405035Z","caller":"traceutil/trace.go:171","msg":"trace[1359154118] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"281.428165ms","start":"2026-09-16T21:44:08.123597Z","end":"2026-09-16T21:44:08.405025Z","steps":["trace[1359154118] 'process raft request'  (duration: 281.111393ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405014Z","caller":"traceutil/trace.go:171","msg":"trace[436271921] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"268.294272ms","start":"2026-09-16T21:44:08.136681Z","end":"2026-09-16T21:44:08.404976Z","steps":["trace[436271921] 'process raft request'  (duration: 268.111321ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.40512Z","caller":"traceutil/trace.go:171","msg":"trace[141072644] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"258.302027ms","start":"2026-09-16T21:44:08.146808Z","end":"2026-09-16T21:44:08.40511Z","steps":["trace[141072644] 'process raft request'  (duration: 258.059685ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405246Z","caller":"traceutil/trace.go:171","msg":"trace[1202550046] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"258.403048ms","start":"2026-09-16T21:44:08.146832Z","end":"2026-09-16T21:44:08.405235Z","steps":["trace[1202550046] 'process raft request'  (duration: 258.200907ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405409Z","caller":"traceutil/trace.go:171","msg":"trace[926452107] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"256.329036ms","start":"2026-09-16T21:44:08.149059Z","end":"2026-09-16T21:44:08.405388Z","steps":["trace[926452107] 'process raft request'  (duration: 256.122115ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405525Z","caller":"traceutil/trace.go:171","msg":"trace[42419142] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"249.140485ms","start":"2026-09-16T21:44:08.156373Z","end":"2026-09-16T21:44:08.405513Z","steps":["trace[42419142] 'process raft request'  (duration: 248.937874ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405573Z","caller":"traceutil/trace.go:171","msg":"trace[799997185] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"247.654438ms","start":"2026-09-16T21:44:08.157904Z","end":"2026-09-16T21:44:08.405558Z","steps":["trace[799997185] 'process raft request'  (duration: 247.471147ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.405587Z","caller":"traceutil/trace.go:171","msg":"trace[658043543] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"213.91514ms","start":"2026-09-16T21:44:08.191654Z","end":"2026-09-16T21:44:08.405569Z","steps":["trace[658043543] 'process raft request'  (duration: 213.818089ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.415229Z","caller":"traceutil/trace.go:171","msg":"trace[1704214034] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"127.267778ms","start":"2026-09-16T21:44:08.287923Z","end":"2026-09-16T21:44:08.415191Z","steps":["trace[1704214034] 'process raft request'  (duration: 126.516024ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.418156Z","caller":"traceutil/trace.go:171","msg":"trace[1007764165] transaction","detail":"{read_only:false; number_of_response:1; response_revision:565; }","duration":"122.633743ms","start":"2026-09-16T21:44:08.295491Z","end":"2026-09-16T21:44:08.418125Z","steps":["trace[1007764165] 'process raft request'  (duration: 119.277503ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:08.422005Z","caller":"traceutil/trace.go:171","msg":"trace[1858729196] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"126.178563ms","start":"2026-09-16T21:44:08.295791Z","end":"2026-09-16T21:44:08.421969Z","steps":["trace[1858729196] 'process raft request'  (duration: 119.088314ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:14.37753Z","caller":"traceutil/trace.go:171","msg":"trace[583136485] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"228.501346ms","start":"2026-09-16T21:44:14.148856Z","end":"2026-09-16T21:44:14.377358Z","steps":["trace[583136485] 'process raft request'  (duration: 227.677539ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:14.750242Z","caller":"traceutil/trace.go:171","msg":"trace[961625368] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"354.857968ms","start":"2026-09-16T21:44:14.395327Z","end":"2026-09-16T21:44:14.750185Z","steps":["trace[961625368] 'process raft request'  (duration: 354.564585ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:14.750524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:14.395299Z","time spent":"355.083451ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-lfc24\" mod_revision:541 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-lfc24\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-lfc24\" > >"}
{"level":"info","ts":"2026-09-16T21:44:14.777533Z","caller":"traceutil/trace.go:171","msg":"trace[946658474] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:677; }","duration":"298.488894ms","start":"2026-09-16T21:44:14.479015Z","end":"2026-09-16T21:44:14.777504Z","steps":["trace[946658474] 'read index received'  (duration: 270.847652ms)","trace[946658474] 'applied index is now lower than readState.Index'  (duration: 27.639502ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:44:14.777656Z","caller":"traceutil/trace.go:171","msg":"trace[1749257295] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"315.233129ms","start":"2026-09-16T21:44:14.462397Z","end":"2026-09-16T21:44:14.77763Z","steps":["trace[1749257295] 'process raft request'  (duration: 314.946226ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:14.777748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.723156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:14.777784Z","caller":"traceutil/trace.go:171","msg":"trace[1274722917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"298.824347ms","start":"2026-09-16T21:44:14.478951Z","end":"2026-09-16T21:44:14.777775Z","steps":["trace[1274722917] 'agreement among raft nodes before linearized reading'  (duration: 298.691456ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:14.777779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:14.462364Z","time spent":"315.34785ms","remote":"127.0.0.1:46692","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-09-16T21:44:15.429542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.11939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-16T21:44:15.430276Z","caller":"traceutil/trace.go:171","msg":"trace[418883314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"414.275251ms","start":"2026-09-16T21:44:15.015345Z","end":"2026-09-16T21:44:15.42962Z","steps":["trace[418883314] 'range keys from in-memory index tree'  (duration: 413.831476ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:15.430394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:15.015328Z","time spent":"415.051069ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-16T21:44:15.491552Z","caller":"traceutil/trace.go:171","msg":"trace[1713232684] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"225.818111ms","start":"2026-09-16T21:44:15.265711Z","end":"2026-09-16T21:44:15.491529Z","steps":["trace[1713232684] 'process raft request'  (duration: 225.315256ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:15.58388Z","caller":"traceutil/trace.go:171","msg":"trace[1415283914] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"145.758431ms","start":"2026-09-16T21:44:15.438083Z","end":"2026-09-16T21:44:15.583841Z","steps":["trace[1415283914] 'process raft request'  (duration: 141.695228ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:15.584074Z","caller":"traceutil/trace.go:171","msg":"trace[1526104993] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:679; }","duration":"105.866233ms","start":"2026-09-16T21:44:15.478182Z","end":"2026-09-16T21:44:15.584048Z","steps":["trace[1526104993] 'read index received'  (duration: 12.835316ms)","trace[1526104993] 'applied index is now lower than readState.Index'  (duration: 93.029217ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:44:15.584245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.036504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:15.584348Z","caller":"traceutil/trace.go:171","msg":"trace[1167563111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"106.180935ms","start":"2026-09-16T21:44:15.478146Z","end":"2026-09-16T21:44:15.584326Z","steps":["trace[1167563111] 'agreement among raft nodes before linearized reading'  (duration: 106.019304ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.587931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.660187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:44:32.588065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.958332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.588104Z","caller":"traceutil/trace.go:171","msg":"trace[1003207164] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"243.037073ms","start":"2026-09-16T21:44:32.345058Z","end":"2026-09-16T21:44:32.588095Z","steps":["trace[1003207164] 'range keys from in-memory index tree'  (duration: 242.86637ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.718929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.588194Z","caller":"traceutil/trace.go:171","msg":"trace[749555238] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:827; }","duration":"161.829091ms","start":"2026-09-16T21:44:32.426347Z","end":"2026-09-16T21:44:32.588177Z","steps":["trace[749555238] 'range keys from in-memory index tree'  (duration: 161.687719ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.148847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:44:32.58811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.132606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:44:32.588356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.127516ms","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-09-16T21:44:32.588393Z","caller":"traceutil/trace.go:171","msg":"trace[1897703485] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"244.197887ms","start":"2026-09-16T21:44:32.344186Z","end":"2026-09-16T21:44:32.588384Z","steps":["trace[1897703485] 'count revisions from in-memory index tree'  (duration: 244.052334ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.588436Z","caller":"traceutil/trace.go:171","msg":"trace[947149397] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"244.441922ms","start":"2026-09-16T21:44:32.343937Z","end":"2026-09-16T21:44:32.588379Z","steps":["trace[947149397] 'range keys from in-memory index tree'  (duration: 244.047894ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.588513Z","caller":"traceutil/trace.go:171","msg":"trace[1450955143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:827; }","duration":"271.703059ms","start":"2026-09-16T21:44:32.316789Z","end":"2026-09-16T21:44:32.588492Z","steps":["trace[1450955143] 'range keys from in-memory index tree'  (duration: 271.097136ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.843858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589172Z","caller":"traceutil/trace.go:171","msg":"trace[429549587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:827; }","duration":"133.717646ms","start":"2026-09-16T21:44:32.455439Z","end":"2026-09-16T21:44:32.589156Z","steps":["trace[429549587] 'range keys from in-memory index tree'  (duration: 132.694535ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.58869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.821878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.588Z","caller":"traceutil/trace.go:171","msg":"trace[703603043] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:827; }","duration":"161.75519ms","start":"2026-09-16T21:44:32.42623Z","end":"2026-09-16T21:44:32.587985Z","steps":["trace[703603043] 'range keys from in-memory index tree'  (duration: 161.622017ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.589254Z","caller":"traceutil/trace.go:171","msg":"trace[1104242342] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:827; }","duration":"134.40919ms","start":"2026-09-16T21:44:32.45483Z","end":"2026-09-16T21:44:32.589239Z","steps":["trace[1104242342] 'range keys from in-memory index tree'  (duration: 133.113743ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.58879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.642618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589441Z","caller":"traceutil/trace.go:171","msg":"trace[504727614] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:827; }","duration":"272.322272ms","start":"2026-09-16T21:44:32.317108Z","end":"2026-09-16T21:44:32.58943Z","steps":["trace[504727614] 'range keys from in-memory index tree'  (duration: 271.593107ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.918006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hzng4\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-09-16T21:44:32.589556Z","caller":"traceutil/trace.go:171","msg":"trace[1205915313] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hzng4; range_end:; response_count:1; response_revision:827; }","duration":"149.689973ms","start":"2026-09-16T21:44:32.439853Z","end":"2026-09-16T21:44:32.589543Z","steps":["trace[1205915313] 'range keys from in-memory index tree'  (duration: 148.782524ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.96825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589637Z","caller":"traceutil/trace.go:171","msg":"trace[939826689] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:827; }","duration":"306.820628ms","start":"2026-09-16T21:44:32.282807Z","end":"2026-09-16T21:44:32.589628Z","steps":["trace[939826689] 'range keys from in-memory index tree'  (duration: 305.902089ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.589666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:32.282788Z","time spent":"306.868039ms","remote":"127.0.0.1:42166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "}
{"level":"warn","ts":"2026-09-16T21:44:32.588843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.679439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589768Z","caller":"traceutil/trace.go:171","msg":"trace[21000341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"361.61829ms","start":"2026-09-16T21:44:32.228139Z","end":"2026-09-16T21:44:32.589757Z","steps":["trace[21000341] 'count revisions from in-memory index tree'  (duration: 360.649788ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.589809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:32.228134Z","time spent":"361.66155ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-09-16T21:44:32.588876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.893768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589857Z","caller":"traceutil/trace.go:171","msg":"trace[824123392] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:827; }","duration":"306.918929ms","start":"2026-09-16T21:44:32.282924Z","end":"2026-09-16T21:44:32.589843Z","steps":["trace[824123392] 'count revisions from in-memory index tree'  (duration: 305.788196ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.314083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.589951Z","caller":"traceutil/trace.go:171","msg":"trace[1002812232] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"362.422655ms","start":"2026-09-16T21:44:32.22752Z","end":"2026-09-16T21:44:32.589943Z","steps":["trace[1002812232] 'range keys from in-memory index tree'  (duration: 361.217921ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.589941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:32.282904Z","time spent":"307.020572ms","remote":"127.0.0.1:42166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-09-16T21:44:32.589981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:32.227502Z","time spent":"362.467437ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-09-16T21:44:32.588911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.804473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.590121Z","caller":"traceutil/trace.go:171","msg":"trace[1014571979] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"362.028688ms","start":"2026-09-16T21:44:32.228081Z","end":"2026-09-16T21:44:32.59011Z","steps":["trace[1014571979] 'range keys from in-memory index tree'  (duration: 360.70796ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.590161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:44:32.228072Z","time spent":"362.077708ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "}
{"level":"warn","ts":"2026-09-16T21:44:32.588925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.122242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.590196Z","caller":"traceutil/trace.go:171","msg":"trace[877425212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:827; }","duration":"109.427229ms","start":"2026-09-16T21:44:32.48076Z","end":"2026-09-16T21:44:32.590188Z","steps":["trace[877425212] 'range keys from in-memory index tree'  (duration: 108.038461ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.588923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.125738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.590269Z","caller":"traceutil/trace.go:171","msg":"trace[1029245468] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:827; }","duration":"273.497215ms","start":"2026-09-16T21:44:32.316763Z","end":"2026-09-16T21:44:32.59026Z","steps":["trace[1029245468] 'count revisions from in-memory index tree'  (duration: 272.041136ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:44:32.58907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.365662ms","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":"warn","ts":"2026-09-16T21:44:32.589068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.012151ms","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":"warn","ts":"2026-09-16T21:44:32.589086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.955499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:44:32.588858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.92187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:44:32.590419Z","caller":"traceutil/trace.go:171","msg":"trace[40632230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:827; }","duration":"135.560283ms","start":"2026-09-16T21:44:32.454848Z","end":"2026-09-16T21:44:32.590408Z","steps":["trace[40632230] 'count revisions from in-memory index tree'  (duration: 133.257666ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.590479Z","caller":"traceutil/trace.go:171","msg":"trace[646665683] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:827; }","duration":"164.802682ms","start":"2026-09-16T21:44:32.425667Z","end":"2026-09-16T21:44:32.590469Z","steps":["trace[646665683] 'count revisions from in-memory index tree'  (duration: 163.294551ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.590568Z","caller":"traceutil/trace.go:171","msg":"trace[1592714404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:827; }","duration":"198.546121ms","start":"2026-09-16T21:44:32.39201Z","end":"2026-09-16T21:44:32.590557Z","steps":["trace[1592714404] 'count revisions from in-memory index tree'  (duration: 196.866388ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:32.590704Z","caller":"traceutil/trace.go:171","msg":"trace[2077305081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:827; }","duration":"198.589803ms","start":"2026-09-16T21:44:32.392106Z","end":"2026-09-16T21:44:32.590696Z","steps":["trace[2077305081] 'range keys from in-memory index tree'  (duration: 196.909288ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:51.871347Z","caller":"traceutil/trace.go:171","msg":"trace[1165128897] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"118.447867ms","start":"2026-09-16T21:44:51.75285Z","end":"2026-09-16T21:44:51.871298Z","steps":["trace[1165128897] 'process raft request'  (duration: 113.925337ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:52.006631Z","caller":"traceutil/trace.go:171","msg":"trace[7813039] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"217.082826ms","start":"2026-09-16T21:44:51.789523Z","end":"2026-09-16T21:44:52.006606Z","steps":["trace[7813039] 'process raft request'  (duration: 203.149332ms)","trace[7813039] 'compare'  (duration: 13.342946ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:44:52.006628Z","caller":"traceutil/trace.go:171","msg":"trace[1507258409] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"166.258358ms","start":"2026-09-16T21:44:51.840339Z","end":"2026-09-16T21:44:52.006598Z","steps":["trace[1507258409] 'process raft request'  (duration: 165.844506ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:44:52.028498Z","caller":"traceutil/trace.go:171","msg":"trace[1349995414] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"153.208979ms","start":"2026-09-16T21:44:51.874993Z","end":"2026-09-16T21:44:52.028202Z","steps":["trace[1349995414] 'process raft request'  (duration: 153.085826ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:45:03.901848Z","caller":"traceutil/trace.go:171","msg":"trace[1273963306] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"168.316453ms","start":"2026-09-16T21:45:03.733505Z","end":"2026-09-16T21:45:03.901822Z","steps":["trace[1273963306] 'process raft request'  (duration: 168.160508ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:22.597194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.259154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:45:22.597354Z","caller":"traceutil/trace.go:171","msg":"trace[391256236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1376; }","duration":"116.472173ms","start":"2026-09-16T21:45:22.480863Z","end":"2026-09-16T21:45:22.597335Z","steps":["trace[391256236] 'range keys from in-memory index tree'  (duration: 116.138829ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.756148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.906756ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862366034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1892 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-16T21:45:56.756612Z","caller":"traceutil/trace.go:171","msg":"trace[1865541991] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"412.3907ms","start":"2026-09-16T21:45:56.3442Z","end":"2026-09-16T21:45:56.756591Z","steps":["trace[1865541991] 'process raft request'  (duration: 412.100777ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:45:56.756637Z","caller":"traceutil/trace.go:171","msg":"trace[134306243] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"509.740028ms","start":"2026-09-16T21:45:56.246859Z","end":"2026-09-16T21:45:56.756599Z","steps":["trace[134306243] 'process raft request'  (duration: 375.245686ms)","trace[134306243] 'compare'  (duration: 133.738249ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:45:56.756691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.344175Z","time spent":"412.482124ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1894 > 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\" > >"}
{"level":"info","ts":"2026-09-16T21:45:56.756703Z","caller":"traceutil/trace.go:171","msg":"trace[662567216] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1996; }","duration":"456.127907ms","start":"2026-09-16T21:45:56.300463Z","end":"2026-09-16T21:45:56.756591Z","steps":["trace[662567216] 'read index received'  (duration: 321.609744ms)","trace[662567216] 'applied index is now lower than readState.Index'  (duration: 134.513483ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:45:56.756878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.246844Z","time spent":"509.892315ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1892 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-09-16T21:45:56.756882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.387828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-09-16T21:45:56.757005Z","caller":"traceutil/trace.go:171","msg":"trace[1545440082] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:1925; }","duration":"456.546205ms","start":"2026-09-16T21:45:56.300426Z","end":"2026-09-16T21:45:56.756972Z","steps":["trace[1545440082] 'agreement among raft nodes before linearized reading'  (duration: 456.257972ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.757092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.300406Z","time spent":"456.667351ms","remote":"127.0.0.1:46244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "}
{"level":"warn","ts":"2026-09-16T21:45:56.757478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.638469ms","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-09-16T21:45:56.757516Z","caller":"traceutil/trace.go:171","msg":"trace[656301473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1925; }","duration":"160.699642ms","start":"2026-09-16T21:45:56.596807Z","end":"2026-09-16T21:45:56.757507Z","steps":["trace[656301473] 'agreement among raft nodes before linearized reading'  (duration: 160.556526ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.757522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.306936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-16T21:45:56.75758Z","caller":"traceutil/trace.go:171","msg":"trace[1729432893] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1925; }","duration":"233.40622ms","start":"2026-09-16T21:45:56.524151Z","end":"2026-09-16T21:45:56.757558Z","steps":["trace[1729432893] 'agreement among raft nodes before linearized reading'  (duration: 233.217322ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.757682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.505104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-16T21:45:56.757729Z","caller":"traceutil/trace.go:171","msg":"trace[1119569104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1925; }","duration":"186.589298ms","start":"2026-09-16T21:45:56.571128Z","end":"2026-09-16T21:45:56.757717Z","steps":["trace[1119569104] 'agreement among raft nodes before linearized reading'  (duration: 186.470593ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.757841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.713087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:45:56.757871Z","caller":"traceutil/trace.go:171","msg":"trace[1383157645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1925; }","duration":"274.807771ms","start":"2026-09-16T21:45:56.483055Z","end":"2026-09-16T21:45:56.757863Z","steps":["trace[1383157645] 'agreement among raft nodes before linearized reading'  (duration: 274.761729ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.758055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.24344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:45:56.758129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.452717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-09-16T21:45:56.758167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.304779ms","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-09-16T21:45:56.758094Z","caller":"traceutil/trace.go:171","msg":"trace[2025750451] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1925; }","duration":"397.340584ms","start":"2026-09-16T21:45:56.360745Z","end":"2026-09-16T21:45:56.758086Z","steps":["trace[2025750451] 'agreement among raft nodes before linearized reading'  (duration: 397.265201ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:45:56.75826Z","caller":"traceutil/trace.go:171","msg":"trace[916495670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1925; }","duration":"161.387872ms","start":"2026-09-16T21:45:56.596818Z","end":"2026-09-16T21:45:56.758206Z","steps":["trace[916495670] 'agreement among raft nodes before linearized reading'  (duration: 161.222495ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.758272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.360712Z","time spent":"397.550533ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"info","ts":"2026-09-16T21:45:56.759834Z","caller":"traceutil/trace.go:171","msg":"trace[1590638594] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1925; }","duration":"427.601723ms","start":"2026-09-16T21:45:56.330565Z","end":"2026-09-16T21:45:56.758167Z","steps":["trace[1590638594] 'agreement among raft nodes before linearized reading'  (duration: 426.802239ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:56.760007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.330535Z","time spent":"429.424244ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-09-16T21:45:56.942971Z","caller":"traceutil/trace.go:171","msg":"trace[1924016819] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"160.285613ms","start":"2026-09-16T21:45:56.782656Z","end":"2026-09-16T21:45:56.942942Z","steps":["trace[1924016819] 'process raft request'  (duration: 77.980191ms)","trace[1924016819] 'compare'  (duration: 82.160185ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:45:57.283385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.650653ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862366047 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1907 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-16T21:45:57.283665Z","caller":"traceutil/trace.go:171","msg":"trace[994139734] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"428.406976ms","start":"2026-09-16T21:45:56.855249Z","end":"2026-09-16T21:45:57.283656Z","steps":["trace[994139734] 'process raft request'  (duration: 189.429918ms)","trace[994139734] 'compare'  (duration: 238.567169ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:45:57.28374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.855202Z","time spent":"428.513281ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1907 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-09-16T21:45:57.283811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.988429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae26556e-e10c-4c8d-8a61-92a6c38b5842\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-09-16T21:45:57.283853Z","caller":"traceutil/trace.go:171","msg":"trace[158970875] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ae26556e-e10c-4c8d-8a61-92a6c38b5842; range_end:; response_count:1; response_revision:1931; }","duration":"428.064332ms","start":"2026-09-16T21:45:56.855778Z","end":"2026-09-16T21:45:57.283843Z","steps":["trace[158970875] 'agreement among raft nodes before linearized reading'  (duration: 427.929026ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:57.283876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.855768Z","time spent":"428.103004ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ae26556e-e10c-4c8d-8a61-92a6c38b5842\" "}
{"level":"info","ts":"2026-09-16T21:45:57.283492Z","caller":"traceutil/trace.go:171","msg":"trace[875200574] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2003; }","duration":"427.652574ms","start":"2026-09-16T21:45:56.855828Z","end":"2026-09-16T21:45:57.28348Z","steps":["trace[875200574] 'read index received'  (duration: 4.802033ms)","trace[875200574] 'applied index is now lower than readState.Index'  (duration: 422.849451ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:45:57.284261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.108361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-09-16T21:45:57.284333Z","caller":"traceutil/trace.go:171","msg":"trace[300320233] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1931; }","duration":"338.233706ms","start":"2026-09-16T21:45:56.946091Z","end":"2026-09-16T21:45:57.284325Z","steps":["trace[300320233] 'agreement among raft nodes before linearized reading'  (duration: 338.115081ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:57.284412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:45:56.946062Z","time spent":"338.34201ms","remote":"127.0.0.1:46364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-09-16T21:45:58.888918Z","caller":"traceutil/trace.go:171","msg":"trace[1763544462] linearizableReadLoop","detail":"{readStateIndex:2018; appliedIndex:2017; }","duration":"116.670154ms","start":"2026-09-16T21:45:58.77223Z","end":"2026-09-16T21:45:58.8889Z","steps":["trace[1763544462] 'read index received'  (duration: 114.395243ms)","trace[1763544462] 'applied index is now lower than readState.Index'  (duration: 2.273891ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:45:58.889022Z","caller":"traceutil/trace.go:171","msg":"trace[223029723] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"119.05104ms","start":"2026-09-16T21:45:58.769961Z","end":"2026-09-16T21:45:58.889012Z","steps":["trace[223029723] 'process raft request'  (duration: 116.726457ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:45:58.889244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.997678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-16T21:45:58.889323Z","caller":"traceutil/trace.go:171","msg":"trace[986539324] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1944; }","duration":"117.106163ms","start":"2026-09-16T21:45:58.772202Z","end":"2026-09-16T21:45:58.889308Z","steps":["trace[986539324] 'agreement among raft nodes before linearized reading'  (duration: 116.941496ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:02.23711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.174326ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:46:02.23722Z","caller":"traceutil/trace.go:171","msg":"trace[985552461] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1979; }","duration":"109.307283ms","start":"2026-09-16T21:46:02.127897Z","end":"2026-09-16T21:46:02.237204Z","steps":["trace[985552461] 'range keys from in-memory index tree'  (duration: 109.141005ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.22781Z","caller":"traceutil/trace.go:171","msg":"trace[719797406] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"195.006841ms","start":"2026-09-16T21:46:09.032769Z","end":"2026-09-16T21:46:09.227776Z","steps":["trace[719797406] 'process raft request'  (duration: 152.083444ms)","trace[719797406] 'compare'  (duration: 42.392813ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:46:09.228658Z","caller":"traceutil/trace.go:171","msg":"trace[111034530] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"194.858325ms","start":"2026-09-16T21:46:09.03378Z","end":"2026-09-16T21:46:09.228639Z","steps":["trace[111034530] 'process raft request'  (duration: 193.942083ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.229085Z","caller":"traceutil/trace.go:171","msg":"trace[1739148979] linearizableReadLoop","detail":"{readStateIndex:2112; appliedIndex:2109; }","duration":"118.861721ms","start":"2026-09-16T21:46:09.109587Z","end":"2026-09-16T21:46:09.228449Z","steps":["trace[1739148979] 'read index received'  (duration: 75.173176ms)","trace[1739148979] 'applied index is now lower than readState.Index'  (duration: 43.686805ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:46:09.229091Z","caller":"traceutil/trace.go:171","msg":"trace[606893674] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"194.705049ms","start":"2026-09-16T21:46:09.034363Z","end":"2026-09-16T21:46:09.229068Z","steps":["trace[606893674] 'process raft request'  (duration: 193.979596ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:09.229217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.624205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-16T21:46:09.229253Z","caller":"traceutil/trace.go:171","msg":"trace[1496272770] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2035; }","duration":"119.740071ms","start":"2026-09-16T21:46:09.109504Z","end":"2026-09-16T21:46:09.229244Z","steps":["trace[1496272770] 'agreement among raft nodes before linearized reading'  (duration: 119.607885ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.54521Z","caller":"traceutil/trace.go:171","msg":"trace[1961219342] linearizableReadLoop","detail":"{readStateIndex:2114; appliedIndex:2113; }","duration":"127.381171ms","start":"2026-09-16T21:46:09.417802Z","end":"2026-09-16T21:46:09.545183Z","steps":["trace[1961219342] 'read index received'  (duration: 2.555538ms)","trace[1961219342] 'applied index is now lower than readState.Index'  (duration: 124.824603ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:46:09.545354Z","caller":"traceutil/trace.go:171","msg":"trace[129069298] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"132.000462ms","start":"2026-09-16T21:46:09.41331Z","end":"2026-09-16T21:46:09.545311Z","steps":["trace[129069298] 'process raft request'  (duration: 131.694578ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:09.545389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.554509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:46:09.54556Z","caller":"traceutil/trace.go:171","msg":"trace[976796709] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2037; }","duration":"127.769639ms","start":"2026-09-16T21:46:09.417761Z","end":"2026-09-16T21:46:09.545531Z","steps":["trace[976796709] 'agreement among raft nodes before linearized reading'  (duration: 127.56092ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.674455Z","caller":"traceutil/trace.go:171","msg":"trace[1992372411] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"121.518742ms","start":"2026-09-16T21:46:09.552905Z","end":"2026-09-16T21:46:09.674424Z","steps":["trace[1992372411] 'process raft request'  (duration: 121.321293ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.674587Z","caller":"traceutil/trace.go:171","msg":"trace[602138486] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"117.56259ms","start":"2026-09-16T21:46:09.556974Z","end":"2026-09-16T21:46:09.674537Z","steps":["trace[602138486] 'process raft request'  (duration: 117.310999ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.674765Z","caller":"traceutil/trace.go:171","msg":"trace[1522377590] linearizableReadLoop","detail":"{readStateIndex:2118; appliedIndex:2115; }","duration":"115.497786ms","start":"2026-09-16T21:46:09.559197Z","end":"2026-09-16T21:46:09.674695Z","steps":["trace[1522377590] 'read index received'  (duration: 88.654285ms)","trace[1522377590] 'applied index is now lower than readState.Index'  (duration: 26.84208ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:46:09.675027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.825081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-16T21:46:09.675069Z","caller":"traceutil/trace.go:171","msg":"trace[455538337] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2042; }","duration":"115.930476ms","start":"2026-09-16T21:46:09.559125Z","end":"2026-09-16T21:46:09.675055Z","steps":["trace[455538337] 'agreement among raft nodes before linearized reading'  (duration: 115.681024ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:09.675158Z","caller":"traceutil/trace.go:171","msg":"trace[368216442] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"122.383252ms","start":"2026-09-16T21:46:09.55275Z","end":"2026-09-16T21:46:09.675134Z","steps":["trace[368216442] 'process raft request'  (duration: 95.08842ms)","trace[368216442] 'compare'  (duration: 26.178811ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:46:36.03683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.619308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-16T21:46:36.036893Z","caller":"traceutil/trace.go:171","msg":"trace[360191054] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2191; }","duration":"143.724862ms","start":"2026-09-16T21:46:35.893157Z","end":"2026-09-16T21:46:36.036882Z","steps":["trace[360191054] 'count revisions from in-memory index tree'  (duration: 143.558424ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:36.072518Z","caller":"traceutil/trace.go:171","msg":"trace[1583844558] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"164.600463ms","start":"2026-09-16T21:46:35.907895Z","end":"2026-09-16T21:46:36.072495Z","steps":["trace[1583844558] 'process raft request'  (duration: 164.479567ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:36.446675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.249445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-09-16T21:46:36.446758Z","caller":"traceutil/trace.go:171","msg":"trace[1175247682] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:2192; }","duration":"145.382201ms","start":"2026-09-16T21:46:36.301356Z","end":"2026-09-16T21:46:36.446738Z","steps":["trace[1175247682] 'range keys from in-memory index tree'  (duration: 145.075257ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:36.446825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.809848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-16T21:46:36.446882Z","caller":"traceutil/trace.go:171","msg":"trace[1921375373] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2192; }","duration":"230.907861ms","start":"2026-09-16T21:46:36.215959Z","end":"2026-09-16T21:46:36.446867Z","steps":["trace[1921375373] 'range keys from in-memory index tree'  (duration: 230.686712ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:37.337743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.80078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-09-16T21:46:37.337848Z","caller":"traceutil/trace.go:171","msg":"trace[123850134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2195; }","duration":"128.949536ms","start":"2026-09-16T21:46:37.208874Z","end":"2026-09-16T21:46:37.337823Z","steps":["trace[123850134] 'range keys from in-memory index tree'  (duration: 128.626811ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:37.547081Z","caller":"traceutil/trace.go:171","msg":"trace[192991182] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"181.820455ms","start":"2026-09-16T21:46:37.365236Z","end":"2026-09-16T21:46:37.547057Z","steps":["trace[192991182] 'read index received'  (duration: 181.580343ms)","trace[192991182] 'applied index is now lower than readState.Index'  (duration: 239.072µs)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:46:37.547215Z","caller":"traceutil/trace.go:171","msg":"trace[1724612566] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"204.531092ms","start":"2026-09-16T21:46:37.34266Z","end":"2026-09-16T21:46:37.547191Z","steps":["trace[1724612566] 'process raft request'  (duration: 204.241858ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:37.547394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.868338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-09-16T21:46:37.547411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.15484ms","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-09-16T21:46:37.547456Z","caller":"traceutil/trace.go:171","msg":"trace[96883034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2196; }","duration":"180.988864ms","start":"2026-09-16T21:46:37.366452Z","end":"2026-09-16T21:46:37.547441Z","steps":["trace[96883034] 'agreement among raft nodes before linearized reading'  (duration: 180.774064ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:46:37.54748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.694256ms","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-09-16T21:46:37.547495Z","caller":"traceutil/trace.go:171","msg":"trace[2083193771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2196; }","duration":"182.255655ms","start":"2026-09-16T21:46:37.365216Z","end":"2026-09-16T21:46:37.547471Z","steps":["trace[2083193771] 'agreement among raft nodes before linearized reading'  (duration: 181.989593ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:46:37.54754Z","caller":"traceutil/trace.go:171","msg":"trace[1942291313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"176.77766ms","start":"2026-09-16T21:46:37.370746Z","end":"2026-09-16T21:46:37.547524Z","steps":["trace[1942291313] 'agreement among raft nodes before linearized reading'  (duration: 176.599391ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:47:11.622518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.053602ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430393107862367114 > lease_revoke:<id:2c81a0ac2c99aab5>","response":"size:28"}
{"level":"info","ts":"2026-09-16T21:47:12.589109Z","caller":"traceutil/trace.go:171","msg":"trace[107374302] linearizableReadLoop","detail":"{readStateIndex:2492; appliedIndex:2491; }","duration":"157.763193ms","start":"2026-09-16T21:47:12.431321Z","end":"2026-09-16T21:47:12.589084Z","steps":["trace[107374302] 'read index received'  (duration: 157.665409ms)","trace[107374302] 'applied index is now lower than readState.Index'  (duration: 96.854µs)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:47:12.589234Z","caller":"traceutil/trace.go:171","msg":"trace[1361938556] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"200.368605ms","start":"2026-09-16T21:47:12.388853Z","end":"2026-09-16T21:47:12.589222Z","steps":["trace[1361938556] 'process raft request'  (duration: 200.066079ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:47:12.589595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.452254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:47:12.5897Z","caller":"traceutil/trace.go:171","msg":"trace[571824229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2401; }","duration":"108.595871ms","start":"2026-09-16T21:47:12.481083Z","end":"2026-09-16T21:47:12.589679Z","steps":["trace[571824229] 'agreement among raft nodes before linearized reading'  (duration: 108.458934ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:47:12.589963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.629337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-09-16T21:47:12.590096Z","caller":"traceutil/trace.go:171","msg":"trace[864617310] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2401; }","duration":"158.804525ms","start":"2026-09-16T21:47:12.431266Z","end":"2026-09-16T21:47:12.59007Z","steps":["trace[864617310] 'agreement among raft nodes before linearized reading'  (duration: 158.537872ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:12.84406Z","caller":"traceutil/trace.go:171","msg":"trace[1464424860] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"177.863394ms","start":"2026-09-16T21:47:12.666175Z","end":"2026-09-16T21:47:12.844038Z","steps":["trace[1464424860] 'process raft request'  (duration: 81.130139ms)","trace[1464424860] 'compare'  (duration: 96.331534ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:47:13.000905Z","caller":"traceutil/trace.go:171","msg":"trace[1282292446] linearizableReadLoop","detail":"{readStateIndex:2496; appliedIndex:2495; }","duration":"104.475714ms","start":"2026-09-16T21:47:12.896406Z","end":"2026-09-16T21:47:13.000882Z","steps":["trace[1282292446] 'read index received'  (duration: 47.375062ms)","trace[1282292446] 'applied index is now lower than readState.Index'  (duration: 57.099482ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:47:13.001069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.626501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:47:13.001103Z","caller":"traceutil/trace.go:171","msg":"trace[1107797860] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2405; }","duration":"104.708165ms","start":"2026-09-16T21:47:12.896383Z","end":"2026-09-16T21:47:13.001091Z","steps":["trace[1107797860] 'agreement among raft nodes before linearized reading'  (duration: 104.60165ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:13.001168Z","caller":"traceutil/trace.go:171","msg":"trace[557667200] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"139.014ms","start":"2026-09-16T21:47:12.862137Z","end":"2026-09-16T21:47:13.001151Z","steps":["trace[557667200] 'process raft request'  (duration: 81.721749ms)","trace[557667200] 'compare'  (duration: 56.818988ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:47:14.689687Z","caller":"traceutil/trace.go:171","msg":"trace[480515595] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"113.042563ms","start":"2026-09-16T21:47:14.576625Z","end":"2026-09-16T21:47:14.689668Z","steps":["trace[480515595] 'process raft request'  (duration: 112.843724ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:14.74731Z","caller":"traceutil/trace.go:171","msg":"trace[1378721730] transaction","detail":"{read_only:false; response_revision:2416; number_of_response:1; }","duration":"151.999406ms","start":"2026-09-16T21:47:14.595265Z","end":"2026-09-16T21:47:14.747265Z","steps":["trace[1378721730] 'process raft request'  (duration: 125.204467ms)","trace[1378721730] 'compare'  (duration: 26.309265ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:47:19.386301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.524544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-fz8cd\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-09-16T21:47:19.386429Z","caller":"traceutil/trace.go:171","msg":"trace[347007720] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-fz8cd; range_end:; response_count:1; response_revision:2472; }","duration":"105.716375ms","start":"2026-09-16T21:47:19.280687Z","end":"2026-09-16T21:47:19.386403Z","steps":["trace[347007720] 'range keys from in-memory index tree'  (duration: 105.241161ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:28.152487Z","caller":"traceutil/trace.go:171","msg":"trace[1102304800] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"216.466239ms","start":"2026-09-16T21:47:27.935994Z","end":"2026-09-16T21:47:28.15246Z","steps":["trace[1102304800] 'process raft request'  (duration: 211.649263ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:28.153581Z","caller":"traceutil/trace.go:171","msg":"trace[690616147] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"217.260488ms","start":"2026-09-16T21:47:27.936312Z","end":"2026-09-16T21:47:28.153572Z","steps":["trace[690616147] 'process raft request'  (duration: 217.09857ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:28.153668Z","caller":"traceutil/trace.go:171","msg":"trace[1601488383] linearizableReadLoop","detail":"{readStateIndex:2676; appliedIndex:2673; }","duration":"134.998627ms","start":"2026-09-16T21:47:28.018663Z","end":"2026-09-16T21:47:28.153661Z","steps":["trace[1601488383] 'read index received'  (duration: 128.996981ms)","trace[1601488383] 'applied index is now lower than readState.Index'  (duration: 6.000886ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:47:28.153793Z","caller":"traceutil/trace.go:171","msg":"trace[1366785800] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"216.722392ms","start":"2026-09-16T21:47:27.937062Z","end":"2026-09-16T21:47:28.153784Z","steps":["trace[1366785800] 'process raft request'  (duration: 216.48618ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:47:28.154028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.351945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:47:28.154076Z","caller":"traceutil/trace.go:171","msg":"trace[1964609880] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2580; }","duration":"135.516023ms","start":"2026-09-16T21:47:28.018545Z","end":"2026-09-16T21:47:28.154061Z","steps":["trace[1964609880] 'agreement among raft nodes before linearized reading'  (duration: 135.428869ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:28.980165Z","caller":"traceutil/trace.go:171","msg":"trace[261893588] transaction","detail":"{read_only:false; response_revision:2582; number_of_response:1; }","duration":"184.512146ms","start":"2026-09-16T21:47:28.795633Z","end":"2026-09-16T21:47:28.980146Z","steps":["trace[261893588] 'process raft request'  (duration: 184.38962ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:47:28.982811Z","caller":"traceutil/trace.go:171","msg":"trace[214981558] linearizableReadLoop","detail":"{readStateIndex:2679; appliedIndex:2677; }","duration":"119.90336ms","start":"2026-09-16T21:47:28.862887Z","end":"2026-09-16T21:47:28.98279Z","steps":["trace[214981558] 'read index received'  (duration: 117.14571ms)","trace[214981558] 'applied index is now lower than readState.Index'  (duration: 2.7568ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:47:28.982915Z","caller":"traceutil/trace.go:171","msg":"trace[189532046] transaction","detail":"{read_only:false; response_revision:2583; number_of_response:1; }","duration":"183.527435ms","start":"2026-09-16T21:47:28.799355Z","end":"2026-09-16T21:47:28.982883Z","steps":["trace[189532046] 'process raft request'  (duration: 183.337936ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:47:28.982952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.044106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-16T21:47:28.983051Z","caller":"traceutil/trace.go:171","msg":"trace[2145539496] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2583; }","duration":"120.188334ms","start":"2026-09-16T21:47:28.862852Z","end":"2026-09-16T21:47:28.98304Z","steps":["trace[2145539496] 'agreement among raft nodes before linearized reading'  (duration: 120.044507ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:01.555486Z","caller":"traceutil/trace.go:171","msg":"trace[2301060] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"472.796273ms","start":"2026-09-16T21:48:01.082671Z","end":"2026-09-16T21:48:01.555467Z","steps":["trace[2301060] 'process raft request'  (duration: 472.683044ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:48:01.555727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:48:01.082642Z","time spent":"473.007411ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2749 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-16T21:48:01.563418Z","caller":"traceutil/trace.go:171","msg":"trace[26042829] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"463.128721ms","start":"2026-09-16T21:48:01.100267Z","end":"2026-09-16T21:48:01.563395Z","steps":["trace[26042829] 'process raft request'  (duration: 462.924473ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:48:01.563568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:48:01.100241Z","time spent":"463.26941ms","remote":"127.0.0.1:46446","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:2750 > 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":"info","ts":"2026-09-16T21:48:01.632275Z","caller":"traceutil/trace.go:171","msg":"trace[373977948] linearizableReadLoop","detail":"{readStateIndex:2861; appliedIndex:2859; }","duration":"144.363078ms","start":"2026-09-16T21:48:01.487893Z","end":"2026-09-16T21:48:01.632256Z","steps":["trace[373977948] 'read index received'  (duration: 67.479517ms)","trace[373977948] 'applied index is now lower than readState.Index'  (duration: 76.882571ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:48:01.632523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.615625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:48:01.63259Z","caller":"traceutil/trace.go:171","msg":"trace[37382998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2759; }","duration":"144.708765ms","start":"2026-09-16T21:48:01.487852Z","end":"2026-09-16T21:48:01.632561Z","steps":["trace[37382998] 'agreement among raft nodes before linearized reading'  (duration: 144.597786ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:07.140391Z","caller":"traceutil/trace.go:171","msg":"trace[1824060684] linearizableReadLoop","detail":"{readStateIndex:2894; appliedIndex:2893; }","duration":"139.151425ms","start":"2026-09-16T21:48:07.001216Z","end":"2026-09-16T21:48:07.140368Z","steps":["trace[1824060684] 'read index received'  (duration: 138.968316ms)","trace[1824060684] 'applied index is now lower than readState.Index'  (duration: 182.289µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:48:07.140531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.287534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:48:07.140568Z","caller":"traceutil/trace.go:171","msg":"trace[1309402524] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2790; }","duration":"139.378193ms","start":"2026-09-16T21:48:07.001179Z","end":"2026-09-16T21:48:07.140557Z","steps":["trace[1309402524] 'agreement among raft nodes before linearized reading'  (duration: 139.272774ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:07.140464Z","caller":"traceutil/trace.go:171","msg":"trace[741851801] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"518.808607ms","start":"2026-09-16T21:48:06.621604Z","end":"2026-09-16T21:48:07.140413Z","steps":["trace[741851801] 'process raft request'  (duration: 518.630978ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:48:07.14103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:48:06.621584Z","time spent":"519.224796ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/auth-system/keycloak-0.18d5eb68a45e8539\" mod_revision:2761 > success:<request_put:<key:\"/registry/events/auth-system/keycloak-0.18d5eb68a45e8539\" value_size:692 lease:3207021071007591557 >> failure:<request_range:<key:\"/registry/events/auth-system/keycloak-0.18d5eb68a45e8539\" > >"}
{"level":"info","ts":"2026-09-16T21:48:07.317392Z","caller":"traceutil/trace.go:171","msg":"trace[569455344] linearizableReadLoop","detail":"{readStateIndex:2895; appliedIndex:2894; }","duration":"146.962392ms","start":"2026-09-16T21:48:07.170401Z","end":"2026-09-16T21:48:07.317363Z","steps":["trace[569455344] 'read index received'  (duration: 55.041793ms)","trace[569455344] 'applied index is now lower than readState.Index'  (duration: 91.919359ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:48:07.317544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.096441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:48:07.317796Z","caller":"traceutil/trace.go:171","msg":"trace[1578388783] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"154.215871ms","start":"2026-09-16T21:48:07.163344Z","end":"2026-09-16T21:48:07.317559Z","steps":["trace[1578388783] 'process raft request'  (duration: 62.132734ms)","trace[1578388783] 'compare'  (duration: 91.68893ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:48:07.318098Z","caller":"traceutil/trace.go:171","msg":"trace[1661233709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2791; }","duration":"147.2068ms","start":"2026-09-16T21:48:07.170356Z","end":"2026-09-16T21:48:07.317563Z","steps":["trace[1661233709] 'agreement among raft nodes before linearized reading'  (duration: 147.094461ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:38.358683Z","caller":"traceutil/trace.go:171","msg":"trace[2005430530] transaction","detail":"{read_only:false; response_revision:2954; number_of_response:1; }","duration":"107.144465ms","start":"2026-09-16T21:48:38.251516Z","end":"2026-09-16T21:48:38.35866Z","steps":["trace[2005430530] 'process raft request'  (duration: 106.697922ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:39.872947Z","caller":"traceutil/trace.go:171","msg":"trace[1178177690] transaction","detail":"{read_only:false; response_revision:2960; number_of_response:1; }","duration":"165.931476ms","start":"2026-09-16T21:48:39.70699Z","end":"2026-09-16T21:48:39.872921Z","steps":["trace[1178177690] 'process raft request'  (duration: 165.766805ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:48:39.883836Z","caller":"traceutil/trace.go:171","msg":"trace[2123700567] linearizableReadLoop","detail":"{readStateIndex:3072; appliedIndex:3070; }","duration":"163.859883ms","start":"2026-09-16T21:48:39.719958Z","end":"2026-09-16T21:48:39.883818Z","steps":["trace[2123700567] 'read index received'  (duration: 152.851558ms)","trace[2123700567] 'applied index is now lower than readState.Index'  (duration: 11.007305ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:48:39.883875Z","caller":"traceutil/trace.go:171","msg":"trace[1320663144] transaction","detail":"{read_only:false; response_revision:2961; number_of_response:1; }","duration":"167.020442ms","start":"2026-09-16T21:48:39.716832Z","end":"2026-09-16T21:48:39.883853Z","steps":["trace[1320663144] 'process raft request'  (duration: 166.835841ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:48:39.884225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.256835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-16T21:48:39.884271Z","caller":"traceutil/trace.go:171","msg":"trace[533302928] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2962; }","duration":"164.358155ms","start":"2026-09-16T21:48:39.7199Z","end":"2026-09-16T21:48:39.884259Z","steps":["trace[533302928] 'agreement among raft nodes before linearized reading'  (duration: 163.991673ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:32.591203Z","caller":"traceutil/trace.go:171","msg":"trace[137961111] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"244.709074ms","start":"2026-09-16T21:52:32.346468Z","end":"2026-09-16T21:52:32.591177Z","steps":["trace[137961111] 'process raft request'  (duration: 244.549028ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:32.610722Z","caller":"traceutil/trace.go:171","msg":"trace[306314122] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5057; }","duration":"128.936467ms","start":"2026-09-16T21:52:32.481763Z","end":"2026-09-16T21:52:32.610699Z","steps":["trace[306314122] 'read index received'  (duration: 109.300271ms)","trace[306314122] 'applied index is now lower than readState.Index'  (duration: 19.635296ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:52:32.610877Z","caller":"traceutil/trace.go:171","msg":"trace[2108532420] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"264.304988ms","start":"2026-09-16T21:52:32.346541Z","end":"2026-09-16T21:52:32.610846Z","steps":["trace[2108532420] 'process raft request'  (duration: 264.006897ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:32.611113Z","caller":"traceutil/trace.go:171","msg":"trace[1495548627] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"262.995217ms","start":"2026-09-16T21:52:32.348094Z","end":"2026-09-16T21:52:32.611089Z","steps":["trace[1495548627] 'process raft request'  (duration: 262.5673ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:32.611128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.342812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:52:32.611232Z","caller":"traceutil/trace.go:171","msg":"trace[440724176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4876; }","duration":"129.455057ms","start":"2026-09-16T21:52:32.481724Z","end":"2026-09-16T21:52:32.611179Z","steps":["trace[440724176] 'agreement among raft nodes before linearized reading'  (duration: 129.324272ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:39.169681Z","caller":"traceutil/trace.go:171","msg":"trace[558164233] linearizableReadLoop","detail":"{readStateIndex:5117; appliedIndex:5116; }","duration":"237.873372ms","start":"2026-09-16T21:52:38.931772Z","end":"2026-09-16T21:52:39.169645Z","steps":["trace[558164233] 'read index received'  (duration: 206.947909ms)","trace[558164233] 'applied index is now lower than readState.Index'  (duration: 30.924443ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-16T21:52:39.169821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.039679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:52:39.169855Z","caller":"traceutil/trace.go:171","msg":"trace[1856749452] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4931; }","duration":"238.115881ms","start":"2026-09-16T21:52:38.931727Z","end":"2026-09-16T21:52:39.169843Z","steps":["trace[1856749452] 'agreement among raft nodes before linearized reading'  (duration: 238.046369ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:39.170153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.381662ms","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-09-16T21:52:39.170259Z","caller":"traceutil/trace.go:171","msg":"trace[1570117567] 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:4931; }","duration":"182.503698ms","start":"2026-09-16T21:52:38.987728Z","end":"2026-09-16T21:52:39.170231Z","steps":["trace[1570117567] 'agreement among raft nodes before linearized reading'  (duration: 182.205275ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:39.170286Z","caller":"traceutil/trace.go:171","msg":"trace[388220863] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"266.925619ms","start":"2026-09-16T21:52:38.902794Z","end":"2026-09-16T21:52:39.169719Z","steps":["trace[388220863] 'process raft request'  (duration: 236.057368ms)","trace[388220863] 'compare'  (duration: 30.440104ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:52:39.408565Z","caller":"traceutil/trace.go:171","msg":"trace[1058025171] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"134.815075ms","start":"2026-09-16T21:52:39.273697Z","end":"2026-09-16T21:52:39.408512Z","steps":["trace[1058025171] 'process raft request'  (duration: 134.581956ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:39.408656Z","caller":"traceutil/trace.go:171","msg":"trace[1739021186] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"134.466381ms","start":"2026-09-16T21:52:39.27416Z","end":"2026-09-16T21:52:39.408626Z","steps":["trace[1739021186] 'process raft request'  (duration: 134.336926ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:39.408769Z","caller":"traceutil/trace.go:171","msg":"trace[798834534] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"134.947071ms","start":"2026-09-16T21:52:39.273766Z","end":"2026-09-16T21:52:39.408713Z","steps":["trace[798834534] 'process raft request'  (duration: 134.66108ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:39.408941Z","caller":"traceutil/trace.go:171","msg":"trace[1745965783] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"134.641208ms","start":"2026-09-16T21:52:39.274282Z","end":"2026-09-16T21:52:39.408923Z","steps":["trace[1745965783] 'process raft request'  (duration: 134.267353ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:42.674878Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430393107862373571,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-16T21:52:42.905393Z","caller":"traceutil/trace.go:171","msg":"trace[693316259] linearizableReadLoop","detail":"{readStateIndex:5210; appliedIndex:5209; }","duration":"731.393788ms","start":"2026-09-16T21:52:42.173976Z","end":"2026-09-16T21:52:42.905369Z","steps":["trace[693316259] 'read index received'  (duration: 731.237932ms)","trace[693316259] 'applied index is now lower than readState.Index'  (duration: 154.706µs)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:52:42.905474Z","caller":"traceutil/trace.go:171","msg":"trace[1391325038] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"736.859508ms","start":"2026-09-16T21:52:42.168589Z","end":"2026-09-16T21:52:42.905448Z","steps":["trace[1391325038] 'process raft request'  (duration: 736.628978ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:42.905785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.168568Z","time spent":"737.068256ms","remote":"127.0.0.1:46446","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:5004 > 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-09-16T21:52:42.905835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.701572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-09-16T21:52:42.905983Z","caller":"traceutil/trace.go:171","msg":"trace[806037113] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5023; }","duration":"732.055056ms","start":"2026-09-16T21:52:42.17391Z","end":"2026-09-16T21:52:42.905965Z","steps":["trace[806037113] 'agreement among raft nodes before linearized reading'  (duration: 731.559685ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:42.906871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.173886Z","time spent":"732.281244ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-09-16T21:52:43.01733Z","caller":"traceutil/trace.go:171","msg":"trace[1656937343] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"176.317337ms","start":"2026-09-16T21:52:42.840986Z","end":"2026-09-16T21:52:43.017303Z","steps":["trace[1656937343] 'process raft request'  (duration: 127.903579ms)","trace[1656937343] 'compare'  (duration: 48.22801ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:52:43.017515Z","caller":"traceutil/trace.go:171","msg":"trace[981454311] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"174.771494ms","start":"2026-09-16T21:52:42.842728Z","end":"2026-09-16T21:52:43.0175Z","steps":["trace[981454311] 'process raft request'  (duration: 174.520884ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:43.017681Z","caller":"traceutil/trace.go:171","msg":"trace[1263880155] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"106.746133ms","start":"2026-09-16T21:52:42.910926Z","end":"2026-09-16T21:52:43.017672Z","steps":["trace[1263880155] 'process raft request'  (duration: 106.696311ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:43.017756Z","caller":"traceutil/trace.go:171","msg":"trace[299920311] linearizableReadLoop","detail":"{readStateIndex:5213; appliedIndex:5210; }","duration":"112.296315ms","start":"2026-09-16T21:52:42.90545Z","end":"2026-09-16T21:52:43.017746Z","steps":["trace[299920311] 'read index received'  (duration: 63.441119ms)","trace[299920311] 'applied index is now lower than readState.Index'  (duration: 48.854276ms)"],"step_count":2}
{"level":"info","ts":"2026-09-16T21:52:43.017741Z","caller":"traceutil/trace.go:171","msg":"trace[1992836398] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"120.963472ms","start":"2026-09-16T21:52:42.896745Z","end":"2026-09-16T21:52:43.017709Z","steps":["trace[1992836398] 'process raft request'  (duration: 120.70343ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.017957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.461374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-09-16T21:52:43.017987Z","caller":"traceutil/trace.go:171","msg":"trace[57338070] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5027; }","duration":"195.508325ms","start":"2026-09-16T21:52:42.82247Z","end":"2026-09-16T21:52:43.017978Z","steps":["trace[57338070] 'agreement among raft nodes before linearized reading'  (duration: 195.345209ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.188443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:52:43.018171Z","caller":"traceutil/trace.go:171","msg":"trace[1952608230] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5027; }","duration":"748.256115ms","start":"2026-09-16T21:52:42.269901Z","end":"2026-09-16T21:52:43.018157Z","steps":["trace[1952608230] 'agreement among raft nodes before linearized reading'  (duration: 748.196493ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.9475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9ldpq.18d5ebac372ee123\" ","response":"range_response_count:1 size:906"}
{"level":"warn","ts":"2026-09-16T21:52:43.018207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.269888Z","time spent":"748.306567ms","remote":"127.0.0.1:34968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-09-16T21:52:43.018238Z","caller":"traceutil/trace.go:171","msg":"trace[1139048889] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9ldpq.18d5ebac372ee123; range_end:; response_count:1; response_revision:5027; }","duration":"617.062975ms","start":"2026-09-16T21:52:42.401157Z","end":"2026-09-16T21:52:43.01822Z","steps":["trace[1139048889] 'agreement among raft nodes before linearized reading'  (duration: 616.813705ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.401135Z","time spent":"617.136468ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":929,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9ldpq.18d5ebac372ee123\" "}
{"level":"warn","ts":"2026-09-16T21:52:43.018541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.985959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:52:43.018585Z","caller":"traceutil/trace.go:171","msg":"trace[739407975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5027; }","duration":"537.064853ms","start":"2026-09-16T21:52:42.481506Z","end":"2026-09-16T21:52:43.018571Z","steps":["trace[739407975] 'agreement among raft nodes before linearized reading'  (duration: 536.99082ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.667903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-nvc69\" ","response":"range_response_count:1 size:5151"}
{"level":"warn","ts":"2026-09-16T21:52:43.018623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.481488Z","time spent":"537.126065ms","remote":"127.0.0.1:46192","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-09-16T21:52:43.01866Z","caller":"traceutil/trace.go:171","msg":"trace[34955629] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-nvc69; range_end:; response_count:1; response_revision:5027; }","duration":"303.758467ms","start":"2026-09-16T21:52:42.714886Z","end":"2026-09-16T21:52:43.018644Z","steps":["trace[34955629] 'agreement among raft nodes before linearized reading'  (duration: 303.607851ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.714869Z","time spent":"303.822649ms","remote":"127.0.0.1:46384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":5174,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-nvc69\" "}
{"level":"warn","ts":"2026-09-16T21:52:43.018725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.260685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-09-16T21:52:43.018745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.8601ms","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-09-16T21:52:43.018777Z","caller":"traceutil/trace.go:171","msg":"trace[2073023415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5027; }","duration":"803.350668ms","start":"2026-09-16T21:52:42.215411Z","end":"2026-09-16T21:52:43.018761Z","steps":["trace[2073023415] 'agreement among raft nodes before linearized reading'  (duration: 803.221913ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:52:43.018791Z","caller":"traceutil/trace.go:171","msg":"trace[1435130585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5027; }","duration":"818.906692ms","start":"2026-09-16T21:52:42.199871Z","end":"2026-09-16T21:52:43.018778Z","steps":["trace[1435130585] 'agreement among raft nodes before linearized reading'  (duration: 818.784057ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.215389Z","time spent":"803.417301ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-16T21:52:43.018832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:42.199804Z","time spent":"819.014376ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-16T21:52:43.018954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.11415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-16T21:52:43.018991Z","caller":"traceutil/trace.go:171","msg":"trace[482139309] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:5027; }","duration":"289.194023ms","start":"2026-09-16T21:52:42.729785Z","end":"2026-09-16T21:52:43.018979Z","steps":["trace[482139309] 'agreement among raft nodes before linearized reading'  (duration: 289.13289ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:43.018999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.673382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc32218a-ce50-4588-8694-ffcc74b1439c\" ","response":"range_response_count:1 size:3936"}
{"level":"info","ts":"2026-09-16T21:52:43.01906Z","caller":"traceutil/trace.go:171","msg":"trace[1124101226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc32218a-ce50-4588-8694-ffcc74b1439c; range_end:; response_count:1; response_revision:5027; }","duration":"245.765356ms","start":"2026-09-16T21:52:42.773282Z","end":"2026-09-16T21:52:43.019047Z","steps":["trace[1124101226] 'agreement among raft nodes before linearized reading'  (duration: 245.610229ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:53.525661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.292646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-16T21:52:53.525725Z","caller":"traceutil/trace.go:171","msg":"trace[364445365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5178; }","duration":"340.386849ms","start":"2026-09-16T21:52:53.185323Z","end":"2026-09-16T21:52:53.52571Z","steps":["trace[364445365] 'range keys from in-memory index tree'  (duration: 340.126298ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:52:53.525758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:52:53.185309Z","time spent":"340.441431ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-16T21:53:19.83551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2858}
{"level":"info","ts":"2026-09-16T21:53:19.914804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2858,"took":"78.223888ms","hash":2013509098,"current-db-size-bytes":51179520,"current-db-size":"51 MB","current-db-size-in-use-bytes":27602944,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-16T21:53:19.914849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2013509098,"revision":2858,"compact-revision":-1}
{"level":"info","ts":"2026-09-16T21:53:23.764599Z","caller":"traceutil/trace.go:171","msg":"trace[792523180] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"104.016203ms","start":"2026-09-16T21:53:23.660546Z","end":"2026-09-16T21:53:23.764563Z","steps":["trace[792523180] 'process raft request'  (duration: 103.651298ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:53:23.99324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.839978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-16T21:53:23.99329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.051987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"info","ts":"2026-09-16T21:53:23.993307Z","caller":"traceutil/trace.go:171","msg":"trace[1775996297] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5455; }","duration":"147.941342ms","start":"2026-09-16T21:53:23.84535Z","end":"2026-09-16T21:53:23.993291Z","steps":["trace[1775996297] 'range keys from in-memory index tree'  (duration: 147.783266ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-16T21:53:23.993337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.055107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-16T21:53:23.993356Z","caller":"traceutil/trace.go:171","msg":"trace[1256395650] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5455; }","duration":"148.11627ms","start":"2026-09-16T21:53:23.845235Z","end":"2026-09-16T21:53:23.993352Z","steps":["trace[1256395650] 'range keys from in-memory index tree'  (duration: 147.888361ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:53:23.993311Z","caller":"traceutil/trace.go:171","msg":"trace[1990271834] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5455; }","duration":"142.096329ms","start":"2026-09-16T21:53:23.851209Z","end":"2026-09-16T21:53:23.993305Z","steps":["trace[1990271834] 'range keys from in-memory index tree'  (duration: 141.928152ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:53:43.979467Z","caller":"traceutil/trace.go:171","msg":"trace[1251281076] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"136.511113ms","start":"2026-09-16T21:53:43.842925Z","end":"2026-09-16T21:53:43.979436Z","steps":["trace[1251281076] 'process raft request'  (duration: 136.270952ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:56:56.817361Z","caller":"traceutil/trace.go:171","msg":"trace[979324192] transaction","detail":"{read_only:false; response_revision:6932; number_of_response:1; }","duration":"130.100156ms","start":"2026-09-16T21:56:56.687223Z","end":"2026-09-16T21:56:56.817323Z","steps":["trace[979324192] 'process raft request'  (duration: 129.745046ms)"],"step_count":1}
{"level":"info","ts":"2026-09-16T21:58:19.840677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5340}
{"level":"info","ts":"2026-09-16T21:58:19.932735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5340,"took":"90.912369ms","hash":2033821972,"current-db-size-bytes":51179520,"current-db-size":"51 MB","current-db-size-in-use-bytes":18784256,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-16T21:58:19.932813Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2033821972,"revision":5340,"compact-revision":2858}