{"level":"warn","ts":"2026-02-26T17:57:07.494989Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T17:57:07.495069Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-02-26T17:57:07.495128Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T17:57:07.495138Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-02-26T17:57:07.495156Z","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-02-26T17:57:07.495787Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-02-26T17:57:07.495862Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-02-26T17:57:07.500368Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.310396ms"} {"level":"info","ts":"2026-02-26T17:57:07.511131Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-02-26T17:57:07.511235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T17:57:07.511261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-02-26T17:57:07.511272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T17:57:07.511285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-02-26T17:57:07.511326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-02-26T17:57:07.519193Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T17:57:07.522517Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T17:57:07.524951Z","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-02-26T17:57:07.528759Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T17:57:07.528903Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T17:57:07.529147Z","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-02-26T17:57:07.529235Z","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-02-26T17:57:07.529252Z","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-02-26T17:57:07.529803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-02-26T17:57:07.529905Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-02-26T17:57:07.533818Z","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-02-26T17:57:07.534161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T17:57:07.534201Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T17:57:07.533743Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-26T17:57:07.534337Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-26T17:57:08.512066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T17:57:08.512133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T17:57:08.512185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-02-26T17:57:08.512206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-02-26T17:57:08.512219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-26T17:57:08.512237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-02-26T17:57:08.512252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-26T17:57:08.5132Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:57:08.514167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T17:57:08.514171Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T17:57:08.514205Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T17:57:08.514531Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T17:57:08.514587Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T17:57:08.515097Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:57:08.515234Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:57:08.515271Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T17:57:08.51701Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T17:57:08.517619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"info","ts":"2026-02-26T17:57:18.783496Z","caller":"traceutil/trace.go:171","msg":"trace[1431022397] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:325; }","duration":"141.950559ms","start":"2026-02-26T17:57:18.641515Z","end":"2026-02-26T17:57:18.783465Z","steps":["trace[1431022397] 'read index received' (duration: 131.012422ms)","trace[1431022397] 'applied index is now lower than readState.Index' (duration: 10.936837ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:18.783614Z","caller":"traceutil/trace.go:171","msg":"trace[603520427] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"184.46743ms","start":"2026-02-26T17:57:18.599101Z","end":"2026-02-26T17:57:18.783568Z","steps":["trace[603520427] 'process raft request' (duration: 173.547374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:18.783826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.292575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-26T17:57:18.78395Z","caller":"traceutil/trace.go:171","msg":"trace[1229874746] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:312; }","duration":"142.462609ms","start":"2026-02-26T17:57:18.641472Z","end":"2026-02-26T17:57:18.783935Z","steps":["trace[1229874746] 'agreement among raft nodes before linearized reading' (duration: 142.193714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:26.082938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.298398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T17:57:26.083008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.83009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T17:57:26.083061Z","caller":"traceutil/trace.go:171","msg":"trace[1888042887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"217.482612ms","start":"2026-02-26T17:57:25.86555Z","end":"2026-02-26T17:57:26.083033Z","steps":["trace[1888042887] 'range keys from in-memory index tree' (duration: 217.155735ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:26.083108Z","caller":"traceutil/trace.go:171","msg":"trace[1297702481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:404; }","duration":"263.999493ms","start":"2026-02-26T17:57:25.819086Z","end":"2026-02-26T17:57:26.083085Z","steps":["trace[1297702481] 'range keys from in-memory index tree' (duration: 263.709728ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:26.641679Z","caller":"traceutil/trace.go:171","msg":"trace[856077354] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"554.353047ms","start":"2026-02-26T17:57:26.087302Z","end":"2026-02-26T17:57:26.641655Z","steps":["trace[856077354] 'process raft request' (duration: 554.171573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:26.642286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:26.087274Z","time spent":"554.481959ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:57:26.761942Z","caller":"traceutil/trace.go:171","msg":"trace[1468970373] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:420; }","duration":"305.955434ms","start":"2026-02-26T17:57:26.455947Z","end":"2026-02-26T17:57:26.761903Z","steps":["trace[1468970373] 'read index received' (duration: 185.546301ms)","trace[1468970373] 'applied index is now lower than readState.Index' (duration: 120.407463ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:26.76218Z","caller":"traceutil/trace.go:171","msg":"trace[437001302] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"674.170547ms","start":"2026-02-26T17:57:26.08785Z","end":"2026-02-26T17:57:26.76202Z","steps":["trace[437001302] 'process raft request' (duration: 672.795819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:26.762256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.84697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:57:26.762346Z","caller":"traceutil/trace.go:171","msg":"trace[1494619185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"222.980822ms","start":"2026-02-26T17:57:26.539343Z","end":"2026-02-26T17:57:26.762324Z","steps":["trace[1494619185] 'agreement among raft nodes before linearized reading' (duration: 222.812918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:26.762426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.401242ms","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-02-26T17:57:26.762523Z","caller":"traceutil/trace.go:171","msg":"trace[1008280446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:406; }","duration":"306.601866ms","start":"2026-02-26T17:57:26.455904Z","end":"2026-02-26T17:57:26.762506Z","steps":["trace[1008280446] 'agreement among raft nodes before linearized reading' (duration: 306.191958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:26.762633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:26.087822Z","time spent":"674.536964ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:57:26.762657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:57:26.45588Z","time spent":"306.722198ms","remote":"127.0.0.1:53384","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-02-26T17:57:45.834012Z","caller":"traceutil/trace.go:171","msg":"trace[1929645362] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"191.660173ms","start":"2026-02-26T17:57:45.642327Z","end":"2026-02-26T17:57:45.833987Z","steps":["trace[1929645362] 'read index received' (duration: 191.471249ms)","trace[1929645362] 'applied index is now lower than readState.Index' (duration: 187.804µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:57:45.834464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.121261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T17:57:45.834552Z","caller":"traceutil/trace.go:171","msg":"trace[2094822578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"192.263614ms","start":"2026-02-26T17:57:45.642267Z","end":"2026-02-26T17:57:45.834531Z","steps":["trace[2094822578] 'agreement among raft nodes before linearized reading' (duration: 191.966188ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:45.834486Z","caller":"traceutil/trace.go:171","msg":"trace[194660397] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"195.009888ms","start":"2026-02-26T17:57:45.639459Z","end":"2026-02-26T17:57:45.834469Z","steps":["trace[194660397] 'process raft request' (duration: 194.382896ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:47.015462Z","caller":"traceutil/trace.go:171","msg":"trace[600684327] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"155.135449ms","start":"2026-02-26T17:57:46.860302Z","end":"2026-02-26T17:57:47.015437Z","steps":["trace[600684327] 'read index received' (duration: 154.881973ms)","trace[600684327] 'applied index is now lower than readState.Index' (duration: 252.496µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:47.015603Z","caller":"traceutil/trace.go:171","msg":"trace[403083628] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"176.85273ms","start":"2026-02-26T17:57:46.838704Z","end":"2026-02-26T17:57:47.015557Z","steps":["trace[403083628] 'process raft request' (duration: 176.587945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:47.015799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.482686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T17:57:47.015881Z","caller":"traceutil/trace.go:171","msg":"trace[695230486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"155.583418ms","start":"2026-02-26T17:57:46.860245Z","end":"2026-02-26T17:57:47.015828Z","steps":["trace[695230486] 'agreement among raft nodes before linearized reading' (duration: 155.421305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:57:47.016055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.326577ms","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-02-26T17:57:47.016172Z","caller":"traceutil/trace.go:171","msg":"trace[744185580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"137.49402ms","start":"2026-02-26T17:57:46.878651Z","end":"2026-02-26T17:57:47.016145Z","steps":["trace[744185580] 'agreement among raft nodes before linearized reading' (duration: 137.194504ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:57:48.533181Z","caller":"traceutil/trace.go:171","msg":"trace[447720817] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"198.065698ms","start":"2026-02-26T17:57:48.335084Z","end":"2026-02-26T17:57:48.53315Z","steps":["trace[447720817] 'process raft request' (duration: 140.199734ms)","trace[447720817] 'compare' (duration: 57.485226ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:48.738927Z","caller":"traceutil/trace.go:171","msg":"trace[1433801510] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"134.888528ms","start":"2026-02-26T17:57:48.604009Z","end":"2026-02-26T17:57:48.738897Z","steps":["trace[1433801510] 'process raft request' (duration: 121.875171ms)","trace[1433801510] 'compare' (duration: 12.820724ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:57:49.090126Z","caller":"traceutil/trace.go:171","msg":"trace[2129331311] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"154.841393ms","start":"2026-02-26T17:57:48.935247Z","end":"2026-02-26T17:57:49.090088Z","steps":["trace[2129331311] 'process raft request' (duration: 96.497858ms)","trace[2129331311] 'compare' (duration: 58.191812ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:06.905034Z","caller":"traceutil/trace.go:171","msg":"trace[1883779023] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"179.965612ms","start":"2026-02-26T17:58:06.725038Z","end":"2026-02-26T17:58:06.905003Z","steps":["trace[1883779023] 'process raft request' (duration: 179.743876ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:07.403394Z","caller":"traceutil/trace.go:171","msg":"trace[2136096058] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"439.873462ms","start":"2026-02-26T17:58:06.963497Z","end":"2026-02-26T17:58:07.40337Z","steps":["trace[2136096058] 'process raft request' (duration: 439.728999ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:07.403583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:06.963465Z","time spent":"440.006705ms","remote":"127.0.0.1:53592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4734,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:58:07.406174Z","caller":"traceutil/trace.go:171","msg":"trace[526402859] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:913; }","duration":"227.907088ms","start":"2026-02-26T17:58:07.178243Z","end":"2026-02-26T17:58:07.40615Z","steps":["trace[526402859] 'read index received' (duration: 224.99552ms)","trace[526402859] 'applied index is now lower than readState.Index' (duration: 2.910138ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:07.406402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.916904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-26T17:58:07.406434Z","caller":"traceutil/trace.go:171","msg":"trace[784224853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:888; }","duration":"198.007887ms","start":"2026-02-26T17:58:07.208416Z","end":"2026-02-26T17:58:07.406424Z","steps":["trace[784224853] 'agreement among raft nodes before linearized reading' (duration: 197.858903ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:07.406422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.355361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-02-26T17:58:07.406434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.288894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-26T17:58:07.406484Z","caller":"traceutil/trace.go:171","msg":"trace[1661402434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:888; }","duration":"170.439422ms","start":"2026-02-26T17:58:07.23603Z","end":"2026-02-26T17:58:07.40647Z","steps":["trace[1661402434] 'agreement among raft nodes before linearized reading' (duration: 170.251908ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:07.406495Z","caller":"traceutil/trace.go:171","msg":"trace[205873045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:888; }","duration":"194.380856ms","start":"2026-02-26T17:58:07.2121Z","end":"2026-02-26T17:58:07.406481Z","steps":["trace[205873045] 'agreement among raft nodes before linearized reading' (duration: 194.215622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:07.406425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.151464ms","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-02-26T17:58:07.406604Z","caller":"traceutil/trace.go:171","msg":"trace[1025066223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:888; }","duration":"228.400979ms","start":"2026-02-26T17:58:07.17818Z","end":"2026-02-26T17:58:07.406581Z","steps":["trace[1025066223] 'agreement among raft nodes before linearized reading' (duration: 228.073182ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:53.961995Z","caller":"traceutil/trace.go:171","msg":"trace[455318592] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"543.946028ms","start":"2026-02-26T17:58:53.418012Z","end":"2026-02-26T17:58:53.961958Z","steps":["trace[455318592] 'process raft request' (duration: 508.004518ms)","trace[455318592] 'compare' (duration: 35.539832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:58:53.962172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.417977Z","time spent":"544.110491ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:58:54.02448Z","caller":"traceutil/trace.go:171","msg":"trace[89327397] linearizableReadLoop","detail":"{readStateIndex:1602; appliedIndex:1600; }","duration":"373.970057ms","start":"2026-02-26T17:58:53.65047Z","end":"2026-02-26T17:58:54.02444Z","steps":["trace[89327397] 'read index received' (duration: 275.463238ms)","trace[89327397] 'applied index is now lower than readState.Index' (duration: 98.505728ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:54.024516Z","caller":"traceutil/trace.go:171","msg":"trace[348841323] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"521.036271ms","start":"2026-02-26T17:58:53.503453Z","end":"2026-02-26T17:58:54.024489Z","steps":["trace[348841323] 'process raft request' (duration: 520.833418ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.024679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.503423Z","time spent":"521.164173ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:58:54.024715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.092918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T17:58:54.024751Z","caller":"traceutil/trace.go:171","msg":"trace[869592550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1539; }","duration":"373.17155ms","start":"2026-02-26T17:58:53.651569Z","end":"2026-02-26T17:58:54.024741Z","steps":["trace[869592550] 'agreement among raft nodes before linearized reading' (duration: 373.030518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.024792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.651547Z","time spent":"373.236691ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T17:58:54.024846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.669844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f52c1609-b822-45b8-9af4-6a53eacf5196\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-02-26T17:58:54.024954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.199882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T17:58:54.024966Z","caller":"traceutil/trace.go:171","msg":"trace[623878498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f52c1609-b822-45b8-9af4-6a53eacf5196; range_end:; response_count:1; response_revision:1539; }","duration":"192.840007ms","start":"2026-02-26T17:58:53.832104Z","end":"2026-02-26T17:58:54.024944Z","steps":["trace[623878498] 'agreement among raft nodes before linearized reading' (duration: 192.541331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.024975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.19409ms","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-02-26T17:58:54.025015Z","caller":"traceutil/trace.go:171","msg":"trace[143191396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1539; }","duration":"372.301813ms","start":"2026-02-26T17:58:53.652699Z","end":"2026-02-26T17:58:54.025Z","steps":["trace[143191396] 'agreement among raft nodes before linearized reading' (duration: 372.086769ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:54.025039Z","caller":"traceutil/trace.go:171","msg":"trace[961871153] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1539; }","duration":"105.325843ms","start":"2026-02-26T17:58:53.919695Z","end":"2026-02-26T17:58:54.025021Z","steps":["trace[961871153] 'agreement among raft nodes before linearized reading' (duration: 105.050977ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.025053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.652676Z","time spent":"372.369215ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T17:58:54.025229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.757021ms","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-02-26T17:58:54.025319Z","caller":"traceutil/trace.go:171","msg":"trace[1022738698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1539; }","duration":"374.880204ms","start":"2026-02-26T17:58:53.650416Z","end":"2026-02-26T17:58:54.025297Z","steps":["trace[1022738698] 'agreement among raft nodes before linearized reading' (duration: 374.14211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.025461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.650396Z","time spent":"375.024836ms","remote":"127.0.0.1:53384","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-02-26T17:58:54.025534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.395632ms","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-02-26T17:58:54.025579Z","caller":"traceutil/trace.go:171","msg":"trace[329186604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1539; }","duration":"359.461633ms","start":"2026-02-26T17:58:53.666105Z","end":"2026-02-26T17:58:54.025566Z","steps":["trace[329186604] 'agreement among raft nodes before linearized reading' (duration: 359.344831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.025618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:53.666094Z","time spent":"359.516714ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T17:58:54.171959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.166819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:58:54.172187Z","caller":"traceutil/trace.go:171","msg":"trace[209866963] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"141.592728ms","start":"2026-02-26T17:58:54.030571Z","end":"2026-02-26T17:58:54.172164Z","steps":["trace[209866963] 'process raft request' (duration: 36.861938ms)","trace[209866963] 'compare' (duration: 103.974496ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:58:54.190653Z","caller":"traceutil/trace.go:171","msg":"trace[851823618] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"159.920656ms","start":"2026-02-26T17:58:54.030697Z","end":"2026-02-26T17:58:54.190618Z","steps":["trace[851823618] 'process raft request' (duration: 159.743323ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:54.190834Z","caller":"traceutil/trace.go:171","msg":"trace[1808469974] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"160.197841ms","start":"2026-02-26T17:58:54.030584Z","end":"2026-02-26T17:58:54.190782Z","steps":["trace[1808469974] 'process raft request' (duration: 159.641671ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:54.190892Z","caller":"traceutil/trace.go:171","msg":"trace[178362494] transaction","detail":"{read_only:false; response_revision:1543; number_of_response:1; }","duration":"159.409916ms","start":"2026-02-26T17:58:54.031466Z","end":"2026-02-26T17:58:54.190876Z","steps":["trace[178362494] 'process raft request' (duration: 159.025669ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:58:54.190856Z","caller":"traceutil/trace.go:171","msg":"trace[922660748] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"157.284734ms","start":"2026-02-26T17:58:54.033536Z","end":"2026-02-26T17:58:54.19082Z","steps":["trace[922660748] 'process raft request' (duration: 157.000578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.660608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.538469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:58:54.660703Z","caller":"traceutil/trace.go:171","msg":"trace[1033966944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1544; }","duration":"119.656242ms","start":"2026-02-26T17:58:54.541025Z","end":"2026-02-26T17:58:54.660682Z","steps":["trace[1033966944] 'range keys from in-memory index tree' (duration: 119.425097ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.66091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.786888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T17:58:54.661046Z","caller":"traceutil/trace.go:171","msg":"trace[49440671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1544; }","duration":"345.994282ms","start":"2026-02-26T17:58:54.315024Z","end":"2026-02-26T17:58:54.661018Z","steps":["trace[49440671] 'range keys from in-memory index tree' (duration: 345.467622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:58:54.661149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:58:54.314999Z","time spent":"346.094454ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T17:59:08.501308Z","caller":"traceutil/trace.go:171","msg":"trace[752321037] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"393.778741ms","start":"2026-02-26T17:59:08.107496Z","end":"2026-02-26T17:59:08.501275Z","steps":["trace[752321037] 'process raft request' (duration: 393.566217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:08.501522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:08.10747Z","time spent":"393.945126ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:59:08.510417Z","caller":"traceutil/trace.go:171","msg":"trace[229508673] linearizableReadLoop","detail":"{readStateIndex:1716; appliedIndex:1714; }","duration":"359.476924ms","start":"2026-02-26T17:59:08.150911Z","end":"2026-02-26T17:59:08.510388Z","steps":["trace[229508673] 'read index received' (duration: 350.151482ms)","trace[229508673] 'applied index is now lower than readState.Index' (duration: 9.324162ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:59:08.510469Z","caller":"traceutil/trace.go:171","msg":"trace[1424219913] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"400.479922ms","start":"2026-02-26T17:59:08.109959Z","end":"2026-02-26T17:59:08.510439Z","steps":["trace[1424219913] 'process raft request' (duration: 400.252878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:08.510687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.77233ms","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":"warn","ts":"2026-02-26T17:59:08.510706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.528048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T17:59:08.510749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.793815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-02-26T17:59:08.510769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:08.109919Z","time spent":"400.612825ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:59:08.510889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.783454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T17:59:08.510883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.790035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-26T17:59:08.510935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.47359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-02-26T17:59:08.510959Z","caller":"traceutil/trace.go:171","msg":"trace[731601264] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1650; }","duration":"359.876012ms","start":"2026-02-26T17:59:08.150853Z","end":"2026-02-26T17:59:08.510729Z","steps":["trace[731601264] 'agreement among raft nodes before linearized reading' (duration: 359.689208ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:08.51097Z","caller":"traceutil/trace.go:171","msg":"trace[956194875] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1650; }","duration":"271.55379ms","start":"2026-02-26T17:59:08.239404Z","end":"2026-02-26T17:59:08.510957Z","steps":["trace[956194875] 'agreement among raft nodes before linearized reading' (duration: 271.336896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:08.510995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:59:08.15083Z","time spent":"360.158647ms","remote":"127.0.0.1:46474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-02-26T17:59:08.51095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.688405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T17:59:08.511066Z","caller":"traceutil/trace.go:171","msg":"trace[92469152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1650; }","duration":"274.63333ms","start":"2026-02-26T17:59:08.236103Z","end":"2026-02-26T17:59:08.510737Z","steps":["trace[92469152] 'agreement among raft nodes before linearized reading' (duration: 274.444707ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:08.511095Z","caller":"traceutil/trace.go:171","msg":"trace[2002117896] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1650; }","duration":"248.889759ms","start":"2026-02-26T17:59:08.262176Z","end":"2026-02-26T17:59:08.511066Z","steps":["trace[2002117896] 'agreement among raft nodes before linearized reading' (duration: 248.593474ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:08.511113Z","caller":"traceutil/trace.go:171","msg":"trace[1694441715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1650; }","duration":"253.863066ms","start":"2026-02-26T17:59:08.256922Z","end":"2026-02-26T17:59:08.510785Z","steps":["trace[1694441715] 'agreement among raft nodes before linearized reading' (duration: 253.735604ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:08.511224Z","caller":"traceutil/trace.go:171","msg":"trace[1848757142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1650; }","duration":"254.849136ms","start":"2026-02-26T17:59:08.256073Z","end":"2026-02-26T17:59:08.510922Z","steps":["trace[1848757142] 'agreement among raft nodes before linearized reading' (duration: 254.698333ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:08.511292Z","caller":"traceutil/trace.go:171","msg":"trace[611994511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1650; }","duration":"254.901136ms","start":"2026-02-26T17:59:08.256031Z","end":"2026-02-26T17:59:08.510932Z","steps":["trace[611994511] 'agreement among raft nodes before linearized reading' (duration: 254.704872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:59:33.803873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.624249ms","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-02-26T17:59:33.803976Z","caller":"traceutil/trace.go:171","msg":"trace[1030423880] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1795; }","duration":"113.774433ms","start":"2026-02-26T17:59:33.69018Z","end":"2026-02-26T17:59:33.803955Z","steps":["trace[1030423880] 'range keys from in-memory index tree' (duration: 113.426716ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:34.734924Z","caller":"traceutil/trace.go:171","msg":"trace[836750389] transaction","detail":"{read_only:false; response_revision:1796; number_of_response:1; }","duration":"130.961233ms","start":"2026-02-26T17:59:34.603939Z","end":"2026-02-26T17:59:34.734901Z","steps":["trace[836750389] 'process raft request' (duration: 130.844561ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:34.764883Z","caller":"traceutil/trace.go:171","msg":"trace[786476376] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"160.774193ms","start":"2026-02-26T17:59:34.604061Z","end":"2026-02-26T17:59:34.764835Z","steps":["trace[786476376] 'process raft request' (duration: 160.537808ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:59:46.898108Z","caller":"traceutil/trace.go:171","msg":"trace[1531367421] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"126.153137ms","start":"2026-02-26T17:59:46.771917Z","end":"2026-02-26T17:59:46.89807Z","steps":["trace[1531367421] 'process raft request' (duration: 125.913743ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:00:49.275959Z","caller":"traceutil/trace.go:171","msg":"trace[969207665] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"133.192122ms","start":"2026-02-26T18:00:49.142732Z","end":"2026-02-26T18:00:49.275924Z","steps":["trace[969207665] 'process raft request' (duration: 132.964807ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:00:49.276859Z","caller":"traceutil/trace.go:171","msg":"trace[1621662084] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"131.994117ms","start":"2026-02-26T18:00:49.14481Z","end":"2026-02-26T18:00:49.276804Z","steps":["trace[1621662084] 'process raft request' (duration: 131.63094ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:03:26.282703Z","caller":"traceutil/trace.go:171","msg":"trace[580279097] transaction","detail":"{read_only:false; response_revision:3225; number_of_response:1; }","duration":"217.579882ms","start":"2026-02-26T18:03:26.065079Z","end":"2026-02-26T18:03:26.282659Z","steps":["trace[580279097] 'process raft request' (duration: 150.541363ms)","trace[580279097] 'compare' (duration: 66.835645ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:13.737451Z","caller":"traceutil/trace.go:171","msg":"trace[314287401] transaction","detail":"{read_only:false; response_revision:4239; number_of_response:1; }","duration":"100.355652ms","start":"2026-02-26T18:05:13.637069Z","end":"2026-02-26T18:05:13.737425Z","steps":["trace[314287401] 'process raft request' (duration: 99.946965ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:19.009415Z","caller":"traceutil/trace.go:171","msg":"trace[1584140339] linearizableReadLoop","detail":"{readStateIndex:4527; appliedIndex:4526; }","duration":"116.946972ms","start":"2026-02-26T18:05:18.892442Z","end":"2026-02-26T18:05:19.009389Z","steps":["trace[1584140339] 'read index received' (duration: 116.687987ms)","trace[1584140339] 'applied index is now lower than readState.Index' (duration: 258.155µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:19.009452Z","caller":"traceutil/trace.go:171","msg":"trace[727553215] transaction","detail":"{read_only:false; response_revision:4348; number_of_response:1; }","duration":"205.858054ms","start":"2026-02-26T18:05:18.803553Z","end":"2026-02-26T18:05:19.009411Z","steps":["trace[727553215] 'process raft request' (duration: 205.584659ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:19.009815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.343139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T18:05:19.009912Z","caller":"traceutil/trace.go:171","msg":"trace[1972151606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4348; }","duration":"117.509743ms","start":"2026-02-26T18:05:18.89238Z","end":"2026-02-26T18:05:19.00989Z","steps":["trace[1972151606] 'agreement among raft nodes before linearized reading' (duration: 117.154466ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:19.020983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.864071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-02-26T18:05:19.021075Z","caller":"traceutil/trace.go:171","msg":"trace[1005979122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4349; }","duration":"101.987935ms","start":"2026-02-26T18:05:18.91907Z","end":"2026-02-26T18:05:19.021058Z","steps":["trace[1005979122] 'agreement among raft nodes before linearized reading' (duration: 101.804001ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:19.849655Z","caller":"traceutil/trace.go:171","msg":"trace[2059443840] linearizableReadLoop","detail":"{readStateIndex:4566; appliedIndex:4565; }","duration":"118.965701ms","start":"2026-02-26T18:05:19.730651Z","end":"2026-02-26T18:05:19.849617Z","steps":["trace[2059443840] 'read index received' (duration: 118.759227ms)","trace[2059443840] 'applied index is now lower than readState.Index' (duration: 205.444µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:19.84974Z","caller":"traceutil/trace.go:171","msg":"trace[770841529] transaction","detail":"{read_only:false; response_revision:4387; number_of_response:1; }","duration":"201.855118ms","start":"2026-02-26T18:05:19.647857Z","end":"2026-02-26T18:05:19.849712Z","steps":["trace[770841529] 'process raft request' (duration: 201.580113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:19.849889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.214075ms","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-02-26T18:05:19.849953Z","caller":"traceutil/trace.go:171","msg":"trace[2028459086] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4387; }","duration":"119.334208ms","start":"2026-02-26T18:05:19.730601Z","end":"2026-02-26T18:05:19.849935Z","steps":["trace[2028459086] 'agreement among raft nodes before linearized reading' (duration: 119.131074ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:20.579494Z","caller":"traceutil/trace.go:171","msg":"trace[1678559343] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"105.613855ms","start":"2026-02-26T18:05:20.473859Z","end":"2026-02-26T18:05:20.579473Z","steps":["trace[1678559343] 'process raft request' (duration: 105.477522ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:20.647397Z","caller":"traceutil/trace.go:171","msg":"trace[1412480703] linearizableReadLoop","detail":"{readStateIndex:4576; appliedIndex:4573; }","duration":"112.043239ms","start":"2026-02-26T18:05:20.535328Z","end":"2026-02-26T18:05:20.647372Z","steps":["trace[1412480703] 'read index received' (duration: 44.038219ms)","trace[1412480703] 'applied index is now lower than readState.Index' (duration: 68.003579ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:20.647566Z","caller":"traceutil/trace.go:171","msg":"trace[274603247] transaction","detail":"{read_only:false; response_revision:4397; number_of_response:1; }","duration":"142.028766ms","start":"2026-02-26T18:05:20.505525Z","end":"2026-02-26T18:05:20.647554Z","steps":["trace[274603247] 'process raft request' (duration: 141.782921ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:20.647564Z","caller":"traceutil/trace.go:171","msg":"trace[1053228410] transaction","detail":"{read_only:false; response_revision:4396; number_of_response:1; }","duration":"148.939099ms","start":"2026-02-26T18:05:20.498603Z","end":"2026-02-26T18:05:20.647542Z","steps":["trace[1053228410] 'process raft request' (duration: 142.010725ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:20.647835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.501127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"warn","ts":"2026-02-26T18:05:20.647817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.783485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:05:20.64789Z","caller":"traceutil/trace.go:171","msg":"trace[1664106352] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4397; }","duration":"112.586349ms","start":"2026-02-26T18:05:20.535273Z","end":"2026-02-26T18:05:20.647859Z","steps":["trace[1664106352] 'agreement among raft nodes before linearized reading' (duration: 112.477477ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:20.647947Z","caller":"traceutil/trace.go:171","msg":"trace[631242320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4397; }","duration":"107.913608ms","start":"2026-02-26T18:05:20.53998Z","end":"2026-02-26T18:05:20.647893Z","steps":["trace[631242320] 'agreement among raft nodes before linearized reading' (duration: 107.778916ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:20.898877Z","caller":"traceutil/trace.go:171","msg":"trace[108095813] linearizableReadLoop","detail":"{readStateIndex:4577; appliedIndex:4576; }","duration":"115.562356ms","start":"2026-02-26T18:05:20.783275Z","end":"2026-02-26T18:05:20.898838Z","steps":["trace[108095813] 'read index received' (duration: 114.280891ms)","trace[108095813] 'applied index is now lower than readState.Index' (duration: 1.280315ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:20.898975Z","caller":"traceutil/trace.go:171","msg":"trace[317102169] transaction","detail":"{read_only:false; response_revision:4398; number_of_response:1; }","duration":"115.706009ms","start":"2026-02-26T18:05:20.78323Z","end":"2026-02-26T18:05:20.898936Z","steps":["trace[317102169] 'process raft request' (duration: 114.393643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:20.899001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.709528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T18:05:20.899059Z","caller":"traceutil/trace.go:171","msg":"trace[1853101564] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:4398; }","duration":"115.812171ms","start":"2026-02-26T18:05:20.783232Z","end":"2026-02-26T18:05:20.899044Z","steps":["trace[1853101564] 'agreement among raft nodes before linearized reading' (duration: 115.696409ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:21.165613Z","caller":"traceutil/trace.go:171","msg":"trace[2086415303] transaction","detail":"{read_only:false; response_revision:4405; number_of_response:1; }","duration":"103.616305ms","start":"2026-02-26T18:05:21.061967Z","end":"2026-02-26T18:05:21.165583Z","steps":["trace[2086415303] 'process raft request' (duration: 103.500853ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:22.834194Z","caller":"traceutil/trace.go:171","msg":"trace[601628479] linearizableReadLoop","detail":"{readStateIndex:4626; appliedIndex:4625; }","duration":"202.622163ms","start":"2026-02-26T18:05:22.631544Z","end":"2026-02-26T18:05:22.834166Z","steps":["trace[601628479] 'read index received' (duration: 202.42383ms)","trace[601628479] 'applied index is now lower than readState.Index' (duration: 197.163µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:22.834319Z","caller":"traceutil/trace.go:171","msg":"trace[309999167] transaction","detail":"{read_only:false; response_revision:4444; number_of_response:1; }","duration":"215.355718ms","start":"2026-02-26T18:05:22.618916Z","end":"2026-02-26T18:05:22.834272Z","steps":["trace[309999167] 'process raft request' (duration: 215.082033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:22.834424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.885848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:05:22.834536Z","caller":"traceutil/trace.go:171","msg":"trace[1095747003] range","detail":"{range_begin:/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache; range_end:; response_count:0; response_revision:4444; }","duration":"203.054081ms","start":"2026-02-26T18:05:22.631455Z","end":"2026-02-26T18:05:22.834509Z","steps":["trace[1095747003] 'agreement among raft nodes before linearized reading' (duration: 202.863177ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:22.841988Z","caller":"traceutil/trace.go:171","msg":"trace[1458999680] transaction","detail":"{read_only:false; response_revision:4445; number_of_response:1; }","duration":"188.873398ms","start":"2026-02-26T18:05:22.653091Z","end":"2026-02-26T18:05:22.841964Z","steps":["trace[1458999680] 'process raft request' (duration: 188.770346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:22.842096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.595726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f7737edf-12fc-4e1b-94b1-4b99561a3572\" ","response":"range_response_count:1 size:4077"} {"level":"info","ts":"2026-02-26T18:05:22.842142Z","caller":"traceutil/trace.go:171","msg":"trace[2008884980] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f7737edf-12fc-4e1b-94b1-4b99561a3572; range_end:; response_count:1; response_revision:4445; }","duration":"170.673148ms","start":"2026-02-26T18:05:22.671455Z","end":"2026-02-26T18:05:22.842129Z","steps":["trace[2008884980] 'agreement among raft nodes before linearized reading' (duration: 170.513144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:26.142741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.487392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:05:26.142857Z","caller":"traceutil/trace.go:171","msg":"trace[1902348105] linearizableReadLoop","detail":"{readStateIndex:4801; appliedIndex:4800; }","duration":"422.734002ms","start":"2026-02-26T18:05:25.720105Z","end":"2026-02-26T18:05:26.142839Z","steps":["trace[1902348105] 'read index received' (duration: 156.043846ms)","trace[1902348105] 'applied index is now lower than readState.Index' (duration: 266.688956ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:26.142944Z","caller":"traceutil/trace.go:171","msg":"trace[432756349] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"436.798303ms","start":"2026-02-26T18:05:25.706134Z","end":"2026-02-26T18:05:26.142932Z","steps":["trace[432756349] 'process raft request' (duration: 170.032246ms)","trace[432756349] 'compare' (duration: 266.35302ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:05:26.142996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:25.706092Z","time spent":"436.877214ms","remote":"127.0.0.1:42864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1811,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T18:05:26.143032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.150382ms","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-02-26T18:05:26.143069Z","caller":"traceutil/trace.go:171","msg":"trace[1554734805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4615; }","duration":"353.225613ms","start":"2026-02-26T18:05:25.789834Z","end":"2026-02-26T18:05:26.143059Z","steps":["trace[1554734805] 'agreement among raft nodes before linearized reading' (duration: 353.122901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:26.143095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:25.789814Z","time spent":"353.275004ms","remote":"127.0.0.1:46406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-02-26T18:05:26.143158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.086327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T18:05:26.143217Z","caller":"traceutil/trace.go:171","msg":"trace[1998644291] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:4615; }","duration":"130.143968ms","start":"2026-02-26T18:05:26.01306Z","end":"2026-02-26T18:05:26.143204Z","steps":["trace[1998644291] 'agreement among raft nodes before linearized reading' (duration: 130.064236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:26.143311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.336208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T18:05:26.143385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.762793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-plgpr\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-02-26T18:05:26.14336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.222582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-02-26T18:05:26.143441Z","caller":"traceutil/trace.go:171","msg":"trace[601488743] range","detail":"{range_begin:/registry/pods/openstack/keepalived-plgpr; range_end:; response_count:1; response_revision:4615; }","duration":"125.854894ms","start":"2026-02-26T18:05:26.017571Z","end":"2026-02-26T18:05:26.143426Z","steps":["trace[601488743] 'agreement among raft nodes before linearized reading' (duration: 125.606659ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:26.143441Z","caller":"traceutil/trace.go:171","msg":"trace[204557363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4615; }","duration":"160.528211ms","start":"2026-02-26T18:05:25.982879Z","end":"2026-02-26T18:05:26.143408Z","steps":["trace[204557363] 'agreement among raft nodes before linearized reading' (duration: 160.301727ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:26.143464Z","caller":"traceutil/trace.go:171","msg":"trace[1279581381] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061; range_end:; response_count:1; response_revision:4615; }","duration":"423.383184ms","start":"2026-02-26T18:05:25.720056Z","end":"2026-02-26T18:05:26.14344Z","steps":["trace[1279581381] 'agreement among raft nodes before linearized reading' (duration: 423.066638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:26.143534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:25.720026Z","time spent":"423.497617ms","remote":"127.0.0.1:53302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061\" "} {"level":"info","ts":"2026-02-26T18:05:26.326749Z","caller":"traceutil/trace.go:171","msg":"trace[1396936430] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"175.518861ms","start":"2026-02-26T18:05:26.151191Z","end":"2026-02-26T18:05:26.32671Z","steps":["trace[1396936430] 'process raft request' (duration: 175.196575ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:26.359232Z","caller":"traceutil/trace.go:171","msg":"trace[822148131] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"207.743551ms","start":"2026-02-26T18:05:26.151461Z","end":"2026-02-26T18:05:26.359205Z","steps":["trace[822148131] 'process raft request' (duration: 207.318833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:26.889886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.311742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:05:26.889965Z","caller":"traceutil/trace.go:171","msg":"trace[2105977170] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4804; }","duration":"259.62512ms","start":"2026-02-26T18:05:26.630328Z","end":"2026-02-26T18:05:26.889953Z","steps":["trace[2105977170] 'read index received' (duration: 91.084664ms)","trace[2105977170] 'applied index is now lower than readState.Index' (duration: 168.539686ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:26.890167Z","caller":"traceutil/trace.go:171","msg":"trace[65892919] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"264.23938ms","start":"2026-02-26T18:05:26.625902Z","end":"2026-02-26T18:05:26.890141Z","steps":["trace[65892919] 'process raft request' (duration: 95.601572ms)","trace[65892919] 'compare' (duration: 168.22281ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:05:26.890582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.248653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777013"} {"level":"info","ts":"2026-02-26T18:05:26.890625Z","caller":"traceutil/trace.go:171","msg":"trace[621164612] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4619; }","duration":"260.330334ms","start":"2026-02-26T18:05:26.630284Z","end":"2026-02-26T18:05:26.890615Z","steps":["trace[621164612] 'agreement among raft nodes before linearized reading' (duration: 259.700131ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:31.37077Z","caller":"traceutil/trace.go:171","msg":"trace[2092529213] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"104.641535ms","start":"2026-02-26T18:05:31.2661Z","end":"2026-02-26T18:05:31.370742Z","steps":["trace[2092529213] 'process raft request' (duration: 102.973413ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:31.374947Z","caller":"traceutil/trace.go:171","msg":"trace[1308128411] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"104.773017ms","start":"2026-02-26T18:05:31.270146Z","end":"2026-02-26T18:05:31.374919Z","steps":["trace[1308128411] 'process raft request' (duration: 104.417581ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:31.374971Z","caller":"traceutil/trace.go:171","msg":"trace[1929049111] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"108.314496ms","start":"2026-02-26T18:05:31.266625Z","end":"2026-02-26T18:05:31.374939Z","steps":["trace[1929049111] 'process raft request' (duration: 107.780046ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:31.37521Z","caller":"traceutil/trace.go:171","msg":"trace[8581187] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"108.512411ms","start":"2026-02-26T18:05:31.266684Z","end":"2026-02-26T18:05:31.375197Z","steps":["trace[8581187] 'process raft request' (duration: 107.853877ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:34.400917Z","caller":"traceutil/trace.go:171","msg":"trace[945119904] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"102.013626ms","start":"2026-02-26T18:05:34.298865Z","end":"2026-02-26T18:05:34.400879Z","steps":["trace[945119904] 'process raft request' (duration: 90.498674ms)","trace[945119904] 'compare' (duration: 11.354058ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:34.436957Z","caller":"traceutil/trace.go:171","msg":"trace[536988445] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"137.261534ms","start":"2026-02-26T18:05:34.29967Z","end":"2026-02-26T18:05:34.436932Z","steps":["trace[536988445] 'process raft request' (duration: 136.711903ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:34.437265Z","caller":"traceutil/trace.go:171","msg":"trace[1698904049] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"137.463127ms","start":"2026-02-26T18:05:34.299778Z","end":"2026-02-26T18:05:34.437242Z","steps":["trace[1698904049] 'process raft request' (duration: 136.781543ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:34.437271Z","caller":"traceutil/trace.go:171","msg":"trace[561601411] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"137.490897ms","start":"2026-02-26T18:05:34.299729Z","end":"2026-02-26T18:05:34.43722Z","steps":["trace[561601411] 'process raft request' (duration: 136.770473ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:35.867966Z","caller":"traceutil/trace.go:171","msg":"trace[56467149] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"172.061034ms","start":"2026-02-26T18:05:35.695876Z","end":"2026-02-26T18:05:35.867937Z","steps":["trace[56467149] 'process raft request' (duration: 171.897481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.537666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.092079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-02-26T18:05:44.537776Z","caller":"traceutil/trace.go:171","msg":"trace[1327535438] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4953; }","duration":"153.268362ms","start":"2026-02-26T18:05:44.384481Z","end":"2026-02-26T18:05:44.537749Z","steps":["trace[1327535438] 'range keys from in-memory index tree' (duration: 152.855554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.537813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.930848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-360b8d8b-8d7e-46dd-8eb4-1801eeeec7ba\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-02-26T18:05:44.537978Z","caller":"traceutil/trace.go:171","msg":"trace[648723744] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-360b8d8b-8d7e-46dd-8eb4-1801eeeec7ba; range_end:; response_count:1; response_revision:4953; }","duration":"190.154973ms","start":"2026-02-26T18:05:44.347771Z","end":"2026-02-26T18:05:44.537926Z","steps":["trace[648723744] 'range keys from in-memory index tree' (duration: 189.678834ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:44.681761Z","caller":"traceutil/trace.go:171","msg":"trace[136871426] linearizableReadLoop","detail":"{readStateIndex:5149; appliedIndex:5148; }","duration":"201.022012ms","start":"2026-02-26T18:05:44.480711Z","end":"2026-02-26T18:05:44.681733Z","steps":["trace[136871426] 'read index received' (duration: 200.87867ms)","trace[136871426] 'applied index is now lower than readState.Index' (duration: 142.222µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:44.681886Z","caller":"traceutil/trace.go:171","msg":"trace[499848828] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"223.521765ms","start":"2026-02-26T18:05:44.458351Z","end":"2026-02-26T18:05:44.681873Z","steps":["trace[499848828] 'process raft request' (duration: 223.196839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.682199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.46262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-360b8d8b-8d7e-46dd-8eb4-1801eeeec7ba\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-02-26T18:05:44.682287Z","caller":"traceutil/trace.go:171","msg":"trace[1175377234] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-360b8d8b-8d7e-46dd-8eb4-1801eeeec7ba; range_end:; response_count:1; response_revision:4954; }","duration":"201.603993ms","start":"2026-02-26T18:05:44.480661Z","end":"2026-02-26T18:05:44.682265Z","steps":["trace[1175377234] 'agreement among raft nodes before linearized reading' (duration: 201.356919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.88821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.621523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:05:44.888446Z","caller":"traceutil/trace.go:171","msg":"trace[914995489] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"124.983067ms","start":"2026-02-26T18:05:44.76344Z","end":"2026-02-26T18:05:44.888423Z","steps":["trace[914995489] 'process raft request' (duration: 124.906165ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:44.888462Z","caller":"traceutil/trace.go:171","msg":"trace[934672609] linearizableReadLoop","detail":"{readStateIndex:5150; appliedIndex:5149; }","duration":"206.607149ms","start":"2026-02-26T18:05:44.681833Z","end":"2026-02-26T18:05:44.88844Z","steps":["trace[934672609] 'read index received' (duration: 72.624949ms)","trace[934672609] 'applied index is now lower than readState.Index' (duration: 133.97687ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:05:44.888556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.251458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:05:44.888598Z","caller":"traceutil/trace.go:171","msg":"trace[330648220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4956; }","duration":"348.309439ms","start":"2026-02-26T18:05:44.540275Z","end":"2026-02-26T18:05:44.888585Z","steps":["trace[330648220] 'agreement among raft nodes before linearized reading' (duration: 348.233497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.888637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.380291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061\" ","response":"range_response_count:1 size:1275"} {"level":"warn","ts":"2026-02-26T18:05:44.88864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:44.540261Z","time spent":"348.368099ms","remote":"127.0.0.1:53066","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-02-26T18:05:44.888705Z","caller":"traceutil/trace.go:171","msg":"trace[241016777] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061; range_end:; response_count:1; response_revision:4956; }","duration":"347.486833ms","start":"2026-02-26T18:05:44.541205Z","end":"2026-02-26T18:05:44.888692Z","steps":["trace[241016777] 'agreement among raft nodes before linearized reading' (duration: 347.285909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:44.888732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:44.541194Z","time spent":"347.531913ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1298,"request content":"key:\"/registry/persistentvolumes/pvc-b2a27f18-ba66-4a0a-8697-e26efc98a061\" "} {"level":"info","ts":"2026-02-26T18:05:44.88842Z","caller":"traceutil/trace.go:171","msg":"trace[1181573014] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"343.123868ms","start":"2026-02-26T18:05:44.545254Z","end":"2026-02-26T18:05:44.888378Z","steps":["trace[1181573014] 'process raft request' (duration: 209.216469ms)","trace[1181573014] 'compare' (duration: 133.43564ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:05:44.888866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:05:44.545236Z","time spent":"343.589548ms","remote":"127.0.0.1:53302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:05:57.433742Z","caller":"traceutil/trace.go:171","msg":"trace[1633826067] linearizableReadLoop","detail":"{readStateIndex:5348; appliedIndex:5347; }","duration":"151.277099ms","start":"2026-02-26T18:05:57.282397Z","end":"2026-02-26T18:05:57.433674Z","steps":["trace[1633826067] 'read index received' (duration: 151.063314ms)","trace[1633826067] 'applied index is now lower than readState.Index' (duration: 212.735µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:05:57.43383Z","caller":"traceutil/trace.go:171","msg":"trace[1064232380] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"196.134277ms","start":"2026-02-26T18:05:57.237654Z","end":"2026-02-26T18:05:57.433788Z","steps":["trace[1064232380] 'process raft request' (duration: 195.837201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:57.43395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.530353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T18:05:57.433999Z","caller":"traceutil/trace.go:171","msg":"trace[542738688] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5146; }","duration":"151.608725ms","start":"2026-02-26T18:05:57.28238Z","end":"2026-02-26T18:05:57.433988Z","steps":["trace[542738688] 'agreement among raft nodes before linearized reading' (duration: 151.493552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:57.434123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.254598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-02-26T18:05:57.434235Z","caller":"traceutil/trace.go:171","msg":"trace[1040565983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5146; }","duration":"148.418872ms","start":"2026-02-26T18:05:57.285781Z","end":"2026-02-26T18:05:57.4342Z","steps":["trace[1040565983] 'agreement among raft nodes before linearized reading' (duration: 148.126646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:57.781742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.611417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-02-26T18:05:57.781798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.88522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-02-26T18:05:57.781837Z","caller":"traceutil/trace.go:171","msg":"trace[781781730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5147; }","duration":"249.75666ms","start":"2026-02-26T18:05:57.532059Z","end":"2026-02-26T18:05:57.781816Z","steps":["trace[781781730] 'range keys from in-memory index tree' (duration: 249.422383ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:57.781889Z","caller":"traceutil/trace.go:171","msg":"trace[810241521] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5147; }","duration":"261.020654ms","start":"2026-02-26T18:05:57.520844Z","end":"2026-02-26T18:05:57.781864Z","steps":["trace[810241521] 'range keys from in-memory index tree' (duration: 260.685037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:57.781919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.607397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T18:05:57.781972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.704609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T18:05:57.782012Z","caller":"traceutil/trace.go:171","msg":"trace[39752211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5147; }","duration":"249.73871ms","start":"2026-02-26T18:05:57.53225Z","end":"2026-02-26T18:05:57.781989Z","steps":["trace[39752211] 'range keys from in-memory index tree' (duration: 249.499885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:05:57.782083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.639845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13288"} {"level":"info","ts":"2026-02-26T18:05:57.782193Z","caller":"traceutil/trace.go:171","msg":"trace[384630244] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5147; }","duration":"262.85376ms","start":"2026-02-26T18:05:57.519323Z","end":"2026-02-26T18:05:57.782176Z","steps":["trace[384630244] 'range keys from in-memory index tree' (duration: 262.256048ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:05:57.782038Z","caller":"traceutil/trace.go:171","msg":"trace[1279943519] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5147; }","duration":"250.805112ms","start":"2026-02-26T18:05:57.531218Z","end":"2026-02-26T18:05:57.782023Z","steps":["trace[1279943519] 'range keys from in-memory index tree' (duration: 250.594638ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:07:08.543987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2744} {"level":"info","ts":"2026-02-26T18:07:08.604456Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2744,"took":"59.005862ms","hash":1848858049,"current-db-size-bytes":40853504,"current-db-size":"41 MB","current-db-size-in-use-bytes":30363648,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-02-26T18:07:08.604542Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1848858049,"revision":2744,"compact-revision":-1} {"level":"info","ts":"2026-02-26T18:10:24.996645Z","caller":"traceutil/trace.go:171","msg":"trace[2060806727] transaction","detail":"{read_only:false; response_revision:6947; number_of_response:1; }","duration":"153.470006ms","start":"2026-02-26T18:10:24.84315Z","end":"2026-02-26T18:10:24.99662Z","steps":["trace[2060806727] 'process raft request' (duration: 134.722036ms)","trace[2060806727] 'compare' (duration: 18.622448ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:11:59.731865Z","caller":"traceutil/trace.go:171","msg":"trace[1656323917] linearizableReadLoop","detail":"{readStateIndex:7967; appliedIndex:7966; }","duration":"245.14148ms","start":"2026-02-26T18:11:59.486686Z","end":"2026-02-26T18:11:59.731828Z","steps":["trace[1656323917] 'read index received' (duration: 244.309012ms)","trace[1656323917] 'applied index is now lower than readState.Index' (duration: 831.148µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:11:59.732052Z","caller":"traceutil/trace.go:171","msg":"trace[473230782] transaction","detail":"{read_only:false; response_revision:7678; number_of_response:1; }","duration":"303.632167ms","start":"2026-02-26T18:11:59.428368Z","end":"2026-02-26T18:11:59.732Z","steps":["trace[473230782] 'process raft request' (duration: 302.703459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:11:59.732194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.485626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T18:11:59.732245Z","caller":"traceutil/trace.go:171","msg":"trace[829146599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7678; }","duration":"245.613128ms","start":"2026-02-26T18:11:59.486619Z","end":"2026-02-26T18:11:59.732232Z","steps":["trace[829146599] 'agreement among raft nodes before linearized reading' (duration: 245.367774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:11:59.732338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:11:59.428351Z","time spent":"303.81954ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:11:59.992933Z","caller":"traceutil/trace.go:171","msg":"trace[1441316602] linearizableReadLoop","detail":"{readStateIndex:7968; appliedIndex:7967; }","duration":"218.565263ms","start":"2026-02-26T18:11:59.774337Z","end":"2026-02-26T18:11:59.992902Z","steps":["trace[1441316602] 'read index received' (duration: 217.101013ms)","trace[1441316602] 'applied index is now lower than readState.Index' (duration: 1.46329ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:11:59.993031Z","caller":"traceutil/trace.go:171","msg":"trace[1273160705] transaction","detail":"{read_only:false; response_revision:7679; number_of_response:1; }","duration":"255.703258ms","start":"2026-02-26T18:11:59.737278Z","end":"2026-02-26T18:11:59.992981Z","steps":["trace[1273160705] 'process raft request' (duration: 254.219569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:11:59.993232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.431682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T18:11:59.993274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.91065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T18:11:59.993378Z","caller":"traceutil/trace.go:171","msg":"trace[719434613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7679; }","duration":"219.041703ms","start":"2026-02-26T18:11:59.774317Z","end":"2026-02-26T18:11:59.993358Z","steps":["trace[719434613] 'agreement among raft nodes before linearized reading' (duration: 218.697546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:11:59.993366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.72342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-02-26T18:11:59.993307Z","caller":"traceutil/trace.go:171","msg":"trace[1888186198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7679; }","duration":"211.513633ms","start":"2026-02-26T18:11:59.781756Z","end":"2026-02-26T18:11:59.99327Z","steps":["trace[1888186198] 'agreement among raft nodes before linearized reading' (duration: 211.310079ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:11:59.993465Z","caller":"traceutil/trace.go:171","msg":"trace[2079861278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7679; }","duration":"205.883642ms","start":"2026-02-26T18:11:59.787559Z","end":"2026-02-26T18:11:59.993443Z","steps":["trace[2079861278] 'agreement among raft nodes before linearized reading' (duration: 205.553026ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:08.556439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5677} {"level":"info","ts":"2026-02-26T18:12:08.655367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5677,"took":"96.859735ms","hash":834314807,"current-db-size-bytes":43372544,"current-db-size":"43 MB","current-db-size-in-use-bytes":23375872,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-02-26T18:12:08.655433Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":834314807,"revision":5677,"compact-revision":2744} {"level":"info","ts":"2026-02-26T18:12:12.152619Z","caller":"traceutil/trace.go:171","msg":"trace[854955666] linearizableReadLoop","detail":"{readStateIndex:8027; appliedIndex:8026; }","duration":"366.800336ms","start":"2026-02-26T18:12:11.785791Z","end":"2026-02-26T18:12:12.152591Z","steps":["trace[854955666] 'read index received' (duration: 366.761595ms)","trace[854955666] 'applied index is now lower than readState.Index' (duration: 36.971µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:12:12.152655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:11.680739Z","time spent":"471.904915ms","remote":"127.0.0.1:53130","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-26T18:12:12.152872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.079372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-02-26T18:12:12.152921Z","caller":"traceutil/trace.go:171","msg":"trace[949048316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7733; }","duration":"367.216574ms","start":"2026-02-26T18:12:11.785694Z","end":"2026-02-26T18:12:12.15291Z","steps":["trace[949048316] 'agreement among raft nodes before linearized reading' (duration: 367.04276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:12.152956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:11.785661Z","time spent":"367.286446ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-26T18:12:12.185017Z","caller":"traceutil/trace.go:171","msg":"trace[1855459948] transaction","detail":"{read_only:false; response_revision:7734; number_of_response:1; }","duration":"195.170462ms","start":"2026-02-26T18:12:11.989786Z","end":"2026-02-26T18:12:12.184957Z","steps":["trace[1855459948] 'process raft request' (duration: 194.810905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:12.185083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.854375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T18:12:12.185228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.875684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T18:12:12.185321Z","caller":"traceutil/trace.go:171","msg":"trace[1725651003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7734; }","duration":"102.931447ms","start":"2026-02-26T18:12:12.082192Z","end":"2026-02-26T18:12:12.185123Z","steps":["trace[1725651003] 'agreement among raft nodes before linearized reading' (duration: 102.701002ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:12.185359Z","caller":"traceutil/trace.go:171","msg":"trace[431410318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7734; }","duration":"105.069308ms","start":"2026-02-26T18:12:12.080259Z","end":"2026-02-26T18:12:12.185329Z","steps":["trace[431410318] 'agreement among raft nodes before linearized reading' (duration: 104.763582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:12.185434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.929035ms","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-02-26T18:12:12.185527Z","caller":"traceutil/trace.go:171","msg":"trace[1732185456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7734; }","duration":"108.080017ms","start":"2026-02-26T18:12:12.077428Z","end":"2026-02-26T18:12:12.185508Z","steps":["trace[1732185456] 'agreement among raft nodes before linearized reading' (duration: 107.627338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:12.185642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.654496ms","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-02-26T18:12:12.185715Z","caller":"traceutil/trace.go:171","msg":"trace[2029094865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7734; }","duration":"124.786308ms","start":"2026-02-26T18:12:12.060915Z","end":"2026-02-26T18:12:12.185702Z","steps":["trace[2029094865] 'agreement among raft nodes before linearized reading' (duration: 123.942782ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:12.321089Z","caller":"traceutil/trace.go:171","msg":"trace[1978273618] transaction","detail":"{read_only:false; response_revision:7739; number_of_response:1; }","duration":"130.110384ms","start":"2026-02-26T18:12:12.190952Z","end":"2026-02-26T18:12:12.321062Z","steps":["trace[1978273618] 'process raft request' (duration: 130.012232ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:12.321126Z","caller":"traceutil/trace.go:171","msg":"trace[842059836] transaction","detail":"{read_only:false; response_revision:7737; number_of_response:1; }","duration":"130.289488ms","start":"2026-02-26T18:12:12.190769Z","end":"2026-02-26T18:12:12.321058Z","steps":["trace[842059836] 'process raft request' (duration: 102.422737ms)","trace[842059836] 'compare' (duration: 27.557925ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:12:12.321079Z","caller":"traceutil/trace.go:171","msg":"trace[1566060888] transaction","detail":"{read_only:false; response_revision:7738; number_of_response:1; }","duration":"130.181026ms","start":"2026-02-26T18:12:12.190852Z","end":"2026-02-26T18:12:12.321033Z","steps":["trace[1566060888] 'process raft request' (duration: 130.062683ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:12.321511Z","caller":"traceutil/trace.go:171","msg":"trace[1224796276] transaction","detail":"{read_only:false; response_revision:7740; number_of_response:1; }","duration":"130.454001ms","start":"2026-02-26T18:12:12.191044Z","end":"2026-02-26T18:12:12.321498Z","steps":["trace[1224796276] 'process raft request' (duration: 129.961551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:12.321855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.724243ms","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-02-26T18:12:12.321958Z","caller":"traceutil/trace.go:171","msg":"trace[1145745170] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:7740; }","duration":"100.903676ms","start":"2026-02-26T18:12:12.221034Z","end":"2026-02-26T18:12:12.321938Z","steps":["trace[1145745170] 'agreement among raft nodes before linearized reading' (duration: 100.59247ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:12.3213Z","caller":"traceutil/trace.go:171","msg":"trace[1004765759] linearizableReadLoop","detail":"{readStateIndex:8034; appliedIndex:8030; }","duration":"100.155682ms","start":"2026-02-26T18:12:12.221105Z","end":"2026-02-26T18:12:12.321261Z","steps":["trace[1004765759] 'read index received' (duration: 72.013765ms)","trace[1004765759] 'applied index is now lower than readState.Index' (duration: 28.139617ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:12:13.336508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.547657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T18:12:13.336681Z","caller":"traceutil/trace.go:171","msg":"trace[1507329992] linearizableReadLoop","detail":"{readStateIndex:8038; appliedIndex:8037; }","duration":"112.21979ms","start":"2026-02-26T18:12:13.224421Z","end":"2026-02-26T18:12:13.336641Z","steps":["trace[1507329992] 'read index received' (duration: 73.581µs)","trace[1507329992] 'applied index is now lower than readState.Index' (duration: 112.143549ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:12:13.336793Z","caller":"traceutil/trace.go:171","msg":"trace[961277981] transaction","detail":"{read_only:false; response_revision:7744; number_of_response:1; }","duration":"597.161343ms","start":"2026-02-26T18:12:12.739522Z","end":"2026-02-26T18:12:13.336683Z","steps":["trace[961277981] 'process raft request' (duration: 122.285609ms)","trace[961277981] 'compare' (duration: 474.314423ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:12:13.336846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.422904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-02-26T18:12:13.337051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:12.739475Z","time spent":"597.434838ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:12:13.337061Z","caller":"traceutil/trace.go:171","msg":"trace[603223844] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7744; }","duration":"112.680389ms","start":"2026-02-26T18:12:13.22436Z","end":"2026-02-26T18:12:13.33704Z","steps":["trace[603223844] 'agreement among raft nodes before linearized reading' (duration: 112.372623ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:14.449357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.297619ms","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-02-26T18:12:14.449448Z","caller":"traceutil/trace.go:171","msg":"trace[479060385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7745; }","duration":"122.431582ms","start":"2026-02-26T18:12:14.326993Z","end":"2026-02-26T18:12:14.449425Z","steps":["trace[479060385] 'range keys from in-memory index tree' (duration: 122.089554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:14.449465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.418112ms","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":"warn","ts":"2026-02-26T18:12:14.449496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.915352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T18:12:14.449498Z","caller":"traceutil/trace.go:171","msg":"trace[129586140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7745; }","duration":"122.500444ms","start":"2026-02-26T18:12:14.326989Z","end":"2026-02-26T18:12:14.449489Z","steps":["trace[129586140] 'range keys from in-memory index tree' (duration: 122.248388ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:14.449547Z","caller":"traceutil/trace.go:171","msg":"trace[1641866217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7745; }","duration":"122.963193ms","start":"2026-02-26T18:12:14.326567Z","end":"2026-02-26T18:12:14.44953Z","steps":["trace[1641866217] 'range keys from in-memory index tree' (duration: 122.763518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:14.449357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.602635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T18:12:14.449608Z","caller":"traceutil/trace.go:171","msg":"trace[832777874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7745; }","duration":"122.878711ms","start":"2026-02-26T18:12:14.326719Z","end":"2026-02-26T18:12:14.449597Z","steps":["trace[832777874] 'range keys from in-memory index tree' (duration: 122.399831ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:42.620404Z","caller":"traceutil/trace.go:171","msg":"trace[1424951398] transaction","detail":"{read_only:false; response_revision:7937; number_of_response:1; }","duration":"400.038287ms","start":"2026-02-26T18:12:42.220336Z","end":"2026-02-26T18:12:42.620375Z","steps":["trace[1424951398] 'process raft request' (duration: 399.882534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:42.620574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.220305Z","time spent":"400.18599ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T18:12:42.621074Z","caller":"traceutil/trace.go:171","msg":"trace[153592202] linearizableReadLoop","detail":"{readStateIndex:8239; appliedIndex:8239; }","duration":"352.334026ms","start":"2026-02-26T18:12:42.268728Z","end":"2026-02-26T18:12:42.621062Z","steps":["trace[153592202] 'read index received' (duration: 352.328656ms)","trace[153592202] 'applied index is now lower than readState.Index' (duration: 4.27µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:12:42.621222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.107933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-02-26T18:12:42.621362Z","caller":"traceutil/trace.go:171","msg":"trace[1344000649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7937; }","duration":"110.272007ms","start":"2026-02-26T18:12:42.511078Z","end":"2026-02-26T18:12:42.62135Z","steps":["trace[1344000649] 'agreement among raft nodes before linearized reading' (duration: 110.049932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:42.622031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.287904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T18:12:42.622067Z","caller":"traceutil/trace.go:171","msg":"trace[2013736905] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:7937; }","duration":"353.357885ms","start":"2026-02-26T18:12:42.268701Z","end":"2026-02-26T18:12:42.622059Z","steps":["trace[2013736905] 'agreement among raft nodes before linearized reading' (duration: 353.276374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:42.622093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.268688Z","time spent":"353.397166ms","remote":"127.0.0.1:53610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-02-26T18:12:43.16826Z","caller":"traceutil/trace.go:171","msg":"trace[2032854100] linearizableReadLoop","detail":"{readStateIndex:8240; appliedIndex:8239; }","duration":"506.641192ms","start":"2026-02-26T18:12:42.661581Z","end":"2026-02-26T18:12:43.168222Z","steps":["trace[2032854100] 'read index received' (duration: 497.658855ms)","trace[2032854100] 'applied index is now lower than readState.Index' (duration: 8.980747ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:12:43.16837Z","caller":"traceutil/trace.go:171","msg":"trace[1798558806] transaction","detail":"{read_only:false; response_revision:7938; number_of_response:1; }","duration":"542.313445ms","start":"2026-02-26T18:12:42.626012Z","end":"2026-02-26T18:12:43.168325Z","steps":["trace[1798558806] 'process raft request' (duration: 533.248246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.168571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.963358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-02-26T18:12:43.168624Z","caller":"traceutil/trace.go:171","msg":"trace[1458791362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7938; }","duration":"507.08357ms","start":"2026-02-26T18:12:42.661525Z","end":"2026-02-26T18:12:43.168608Z","steps":["trace[1458791362] 'agreement among raft nodes before linearized reading' (duration: 506.861696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.168662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.661497Z","time spent":"507.156411ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T18:12:43.168657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.626Z","time spent":"542.463618ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:12:43.173637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.946837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T18:12:43.1737Z","caller":"traceutil/trace.go:171","msg":"trace[935899051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7941; }","duration":"512.055079ms","start":"2026-02-26T18:12:42.661629Z","end":"2026-02-26T18:12:43.173684Z","steps":["trace[935899051] 'agreement among raft nodes before linearized reading' (duration: 511.830634ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.173819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.661593Z","time spent":"512.13738ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T18:12:43.174086Z","caller":"traceutil/trace.go:171","msg":"trace[22636146] transaction","detail":"{read_only:false; response_revision:7939; number_of_response:1; }","duration":"286.7654ms","start":"2026-02-26T18:12:42.887311Z","end":"2026-02-26T18:12:43.174076Z","steps":["trace[22636146] 'process raft request' (duration: 285.969455ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:43.174248Z","caller":"traceutil/trace.go:171","msg":"trace[62419086] transaction","detail":"{read_only:false; response_revision:7940; number_of_response:1; }","duration":"250.824031ms","start":"2026-02-26T18:12:42.923416Z","end":"2026-02-26T18:12:43.17424Z","steps":["trace[62419086] 'process raft request' (duration: 249.964074ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:43.174414Z","caller":"traceutil/trace.go:171","msg":"trace[511051184] transaction","detail":"{read_only:false; response_revision:7941; number_of_response:1; }","duration":"250.502385ms","start":"2026-02-26T18:12:42.923904Z","end":"2026-02-26T18:12:43.174406Z","steps":["trace[511051184] 'process raft request' (duration: 249.511656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.174619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.311314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-plgpr\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T18:12:43.174646Z","caller":"traceutil/trace.go:171","msg":"trace[1345741982] range","detail":"{range_begin:/registry/pods/openstack/keepalived-plgpr; range_end:; response_count:1; response_revision:7941; }","duration":"242.365455ms","start":"2026-02-26T18:12:42.932275Z","end":"2026-02-26T18:12:43.17464Z","steps":["trace[1345741982] 'agreement among raft nodes before linearized reading' (duration: 242.280323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.17495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.778556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T18:12:43.174981Z","caller":"traceutil/trace.go:171","msg":"trace[1977995846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7941; }","duration":"498.863838ms","start":"2026-02-26T18:12:42.67611Z","end":"2026-02-26T18:12:43.174974Z","steps":["trace[1977995846] 'agreement among raft nodes before linearized reading' (duration: 498.787776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.175003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.676083Z","time spent":"498.912838ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T18:12:43.175221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.487357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-26T18:12:43.17525Z","caller":"traceutil/trace.go:171","msg":"trace[515420012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7942; }","duration":"513.536258ms","start":"2026-02-26T18:12:42.661707Z","end":"2026-02-26T18:12:43.175243Z","steps":["trace[515420012] 'agreement among raft nodes before linearized reading' (duration: 513.438866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:43.17527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:42.6617Z","time spent":"513.565178ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T18:12:46.370575Z","caller":"traceutil/trace.go:171","msg":"trace[1997632953] transaction","detail":"{read_only:false; response_revision:7955; number_of_response:1; }","duration":"143.097215ms","start":"2026-02-26T18:12:46.227437Z","end":"2026-02-26T18:12:46.370535Z","steps":["trace[1997632953] 'process raft request' (duration: 142.749178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:46.891643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.912926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:12:46.891764Z","caller":"traceutil/trace.go:171","msg":"trace[1447106420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7955; }","duration":"352.08225ms","start":"2026-02-26T18:12:46.539654Z","end":"2026-02-26T18:12:46.891736Z","steps":["trace[1447106420] 'range keys from in-memory index tree' (duration: 351.752424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:46.891813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:46.539631Z","time spent":"352.169781ms","remote":"127.0.0.1:53066","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-02-26T18:12:56.231123Z","caller":"traceutil/trace.go:171","msg":"trace[1191701610] transaction","detail":"{read_only:false; response_revision:8048; number_of_response:1; }","duration":"169.863993ms","start":"2026-02-26T18:12:56.061223Z","end":"2026-02-26T18:12:56.231087Z","steps":["trace[1191701610] 'process raft request' (duration: 169.595367ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:56.352096Z","caller":"traceutil/trace.go:171","msg":"trace[561140708] transaction","detail":"{read_only:false; response_revision:8050; number_of_response:1; }","duration":"108.854738ms","start":"2026-02-26T18:12:56.243209Z","end":"2026-02-26T18:12:56.352063Z","steps":["trace[561140708] 'process raft request' (duration: 100.524084ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:57.478577Z","caller":"traceutil/trace.go:171","msg":"trace[250423940] linearizableReadLoop","detail":"{readStateIndex:8361; appliedIndex:8360; }","duration":"268.740236ms","start":"2026-02-26T18:12:57.209802Z","end":"2026-02-26T18:12:57.478542Z","steps":["trace[250423940] 'read index received' (duration: 182.025084ms)","trace[250423940] 'applied index is now lower than readState.Index' (duration: 86.713312ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T18:12:57.478758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.921849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T18:12:57.478829Z","caller":"traceutil/trace.go:171","msg":"trace[1699950543] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8052; }","duration":"269.055521ms","start":"2026-02-26T18:12:57.209754Z","end":"2026-02-26T18:12:57.47881Z","steps":["trace[1699950543] 'agreement among raft nodes before linearized reading' (duration: 268.893018ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:57.578699Z","caller":"traceutil/trace.go:171","msg":"trace[352677555] transaction","detail":"{read_only:false; response_revision:8053; number_of_response:1; }","duration":"318.440255ms","start":"2026-02-26T18:12:57.260209Z","end":"2026-02-26T18:12:57.57865Z","steps":["trace[352677555] 'process raft request' (duration: 318.16819ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:57.578857Z","caller":"traceutil/trace.go:171","msg":"trace[1234308222] transaction","detail":"{read_only:false; response_revision:8055; number_of_response:1; }","duration":"285.159199ms","start":"2026-02-26T18:12:57.293673Z","end":"2026-02-26T18:12:57.578832Z","steps":["trace[1234308222] 'process raft request' (duration: 284.928784ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:57.578892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T18:12:57.260175Z","time spent":"318.612659ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T18:12:57.578998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.788887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-26T18:12:57.579073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.129573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T18:12:57.579143Z","caller":"traceutil/trace.go:171","msg":"trace[2123820881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8055; }","duration":"227.004802ms","start":"2026-02-26T18:12:57.352086Z","end":"2026-02-26T18:12:57.579091Z","steps":["trace[2123820881] 'agreement among raft nodes before linearized reading' (duration: 226.581844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:57.579019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.802757ms","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-02-26T18:12:57.579219Z","caller":"traceutil/trace.go:171","msg":"trace[405790715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8055; }","duration":"227.038793ms","start":"2026-02-26T18:12:57.35217Z","end":"2026-02-26T18:12:57.579209Z","steps":["trace[405790715] 'agreement among raft nodes before linearized reading' (duration: 226.734206ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:57.578996Z","caller":"traceutil/trace.go:171","msg":"trace[1895133399] transaction","detail":"{read_only:false; response_revision:8054; number_of_response:1; }","duration":"286.855243ms","start":"2026-02-26T18:12:57.292085Z","end":"2026-02-26T18:12:57.57894Z","steps":["trace[1895133399] 'process raft request' (duration: 286.465625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:57.578991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.478169ms","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-02-26T18:12:57.579586Z","caller":"traceutil/trace.go:171","msg":"trace[728621334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8055; }","duration":"229.121353ms","start":"2026-02-26T18:12:57.350436Z","end":"2026-02-26T18:12:57.579558Z","steps":["trace[728621334] 'agreement among raft nodes before linearized reading' (duration: 228.417018ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:12:57.57937Z","caller":"traceutil/trace.go:171","msg":"trace[1430567776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8055; }","duration":"228.382648ms","start":"2026-02-26T18:12:57.350716Z","end":"2026-02-26T18:12:57.579099Z","steps":["trace[1430567776] 'agreement among raft nodes before linearized reading' (duration: 228.096632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:57.5794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.991251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T18:12:57.579875Z","caller":"traceutil/trace.go:171","msg":"trace[1889335123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8055; }","duration":"229.502221ms","start":"2026-02-26T18:12:57.350349Z","end":"2026-02-26T18:12:57.579851Z","steps":["trace[1889335123] 'agreement among raft nodes before linearized reading' (duration: 228.378858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:12:57.579448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.787997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-plgpr\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T18:12:57.579992Z","caller":"traceutil/trace.go:171","msg":"trace[196838611] range","detail":"{range_begin:/registry/pods/openstack/keepalived-plgpr; range_end:; response_count:1; response_revision:8055; }","duration":"227.998992ms","start":"2026-02-26T18:12:57.351982Z","end":"2026-02-26T18:12:57.579981Z","steps":["trace[196838611] 'agreement among raft nodes before linearized reading' (duration: 226.686736ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:13:09.732368Z","caller":"traceutil/trace.go:171","msg":"trace[202046183] transaction","detail":"{read_only:false; response_revision:8144; number_of_response:1; }","duration":"109.486871ms","start":"2026-02-26T18:13:09.622853Z","end":"2026-02-26T18:13:09.73234Z","steps":["trace[202046183] 'process raft request' (duration: 109.209176ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:13:09.732401Z","caller":"traceutil/trace.go:171","msg":"trace[44231474] transaction","detail":"{read_only:false; response_revision:8145; number_of_response:1; }","duration":"107.156075ms","start":"2026-02-26T18:13:09.625214Z","end":"2026-02-26T18:13:09.73237Z","steps":["trace[44231474] 'process raft request' (duration: 107.030782ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:13:09.732492Z","caller":"traceutil/trace.go:171","msg":"trace[2099474607] transaction","detail":"{read_only:false; response_revision:8143; number_of_response:1; }","duration":"162.918927ms","start":"2026-02-26T18:13:09.568764Z","end":"2026-02-26T18:13:09.731683Z","steps":["trace[2099474607] 'process raft request' (duration: 162.697102ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:13:09.732625Z","caller":"traceutil/trace.go:171","msg":"trace[1920982338] transaction","detail":"{read_only:false; response_revision:8146; number_of_response:1; }","duration":"107.151485ms","start":"2026-02-26T18:13:09.625463Z","end":"2026-02-26T18:13:09.732615Z","steps":["trace[1920982338] 'process raft request' (duration: 106.816739ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:14:01.080749Z","caller":"traceutil/trace.go:171","msg":"trace[787509288] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"108.516322ms","start":"2026-02-26T18:14:00.972182Z","end":"2026-02-26T18:14:01.080699Z","steps":["trace[787509288] 'process raft request' (duration: 108.299837ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:14:14.20978Z","caller":"traceutil/trace.go:171","msg":"trace[1557997672] linearizableReadLoop","detail":"{readStateIndex:9092; appliedIndex:9089; }","duration":"158.496018ms","start":"2026-02-26T18:14:14.05126Z","end":"2026-02-26T18:14:14.209756Z","steps":["trace[1557997672] 'read index received' (duration: 15.617818ms)","trace[1557997672] 'applied index is now lower than readState.Index' (duration: 142.87695ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:14:14.209924Z","caller":"traceutil/trace.go:171","msg":"trace[55575318] transaction","detail":"{read_only:false; response_revision:8761; number_of_response:1; }","duration":"218.047444ms","start":"2026-02-26T18:14:13.991856Z","end":"2026-02-26T18:14:14.209904Z","steps":["trace[55575318] 'process raft request' (duration: 217.83742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:14:14.210087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.802544ms","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-02-26T18:14:14.210126Z","caller":"traceutil/trace.go:171","msg":"trace[820709531] transaction","detail":"{read_only:false; response_revision:8760; number_of_response:1; }","duration":"218.349041ms","start":"2026-02-26T18:14:13.991736Z","end":"2026-02-26T18:14:14.210085Z","steps":["trace[820709531] 'process raft request' (duration: 165.10506ms)","trace[820709531] 'compare' (duration: 52.730591ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T18:14:14.210161Z","caller":"traceutil/trace.go:171","msg":"trace[1416376996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8761; }","duration":"158.923757ms","start":"2026-02-26T18:14:14.05122Z","end":"2026-02-26T18:14:14.210144Z","steps":["trace[1416376996] 'agreement among raft nodes before linearized reading' (duration: 158.712183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:14:14.210351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.895494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T18:14:14.210423Z","caller":"traceutil/trace.go:171","msg":"trace[1407617421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8761; }","duration":"129.004067ms","start":"2026-02-26T18:14:14.0814Z","end":"2026-02-26T18:14:14.210405Z","steps":["trace[1407617421] 'agreement among raft nodes before linearized reading' (duration: 128.763792ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:14:14.210393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.452227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T18:14:14.210442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T18:14:14.210518Z","caller":"traceutil/trace.go:171","msg":"trace[543996715] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8761; }","duration":"156.649831ms","start":"2026-02-26T18:14:14.053836Z","end":"2026-02-26T18:14:14.210486Z","steps":["trace[543996715] 'agreement among raft nodes before linearized reading' (duration: 156.262164ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:14:14.210639Z","caller":"traceutil/trace.go:171","msg":"trace[1833682849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8761; }","duration":"129.503327ms","start":"2026-02-26T18:14:14.081116Z","end":"2026-02-26T18:14:14.21062Z","steps":["trace[1833682849] 'agreement among raft nodes before linearized reading' (duration: 129.122389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T18:14:14.210731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.798015ms","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-02-26T18:14:14.210836Z","caller":"traceutil/trace.go:171","msg":"trace[1601565483] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8761; }","duration":"119.929748ms","start":"2026-02-26T18:14:14.090892Z","end":"2026-02-26T18:14:14.210822Z","steps":["trace[1601565483] 'agreement among raft nodes before linearized reading' (duration: 119.261244ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T18:16:28.964572Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"adfb641115bf6cbd","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-02-26T18:16:28.96906Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-02-26T18:16:28.969212Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-02-26T18:17:08.562288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7722} {"level":"info","ts":"2026-02-26T18:17:08.629289Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7722,"took":"64.766669ms","hash":973664503,"current-db-size-bytes":43372544,"current-db-size":"43 MB","current-db-size-in-use-bytes":25370624,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-02-26T18:17:08.629365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":973664503,"revision":7722,"compact-revision":5677}