{"level":"warn","ts":"2026-02-25T15:06:19.578028Z","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-25T15:06:19.578155Z","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-25T15:06:19.578278Z","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-25T15:06:19.5784Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-02-25T15:06:19.578451Z","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-25T15:06:19.579513Z","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-25T15:06:19.579615Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.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-25T15:06:19.59083Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.731335ms"} {"level":"info","ts":"2026-02-25T15:06:19.646043Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-02-25T15:06:19.646149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T15:06:19.646205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-02-25T15:06:19.646222Z","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-25T15:06:19.646376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-02-25T15:06:19.646444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-02-25T15:06:19.655611Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T15:06:19.657296Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T15:06:19.658566Z","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-25T15:06:19.660786Z","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-25T15:06:19.661099Z","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-25T15:06:19.661338Z","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-25T15:06:19.661445Z","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-25T15:06:19.66151Z","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-25T15:06:19.664014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-02-25T15:06:19.66437Z","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-25T15:06:19.667701Z","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-25T15:06:19.66786Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-25T15:06:19.667905Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-02-25T15:06:19.668146Z","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-25T15:06:19.668228Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T15:06:20.447573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T15:06:20.447679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T15:06:20.448036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-02-25T15:06:20.448193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-02-25T15:06:20.44823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-25T15:06:20.448258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-02-25T15:06:20.448287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-02-25T15:06:20.449663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:06:20.459848Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:06:20.459851Z","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-25T15:06:20.459934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T15:06:20.460541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T15:06:20.460584Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T15:06:20.461769Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T15:06:20.463524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"info","ts":"2026-02-25T15:06:20.464753Z","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-25T15:06:20.464929Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:06:20.464977Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T15:06:21.915242Z","caller":"traceutil/trace.go:171","msg":"trace[140757518] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"138.263978ms","start":"2026-02-25T15:06:21.776947Z","end":"2026-02-25T15:06:21.915211Z","steps":["trace[140757518] 'process raft request' (duration: 131.811072ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:21.915259Z","caller":"traceutil/trace.go:171","msg":"trace[882933059] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"124.753545ms","start":"2026-02-25T15:06:21.790477Z","end":"2026-02-25T15:06:21.915231Z","steps":["trace[882933059] 'process raft request' (duration: 124.711824ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:21.915355Z","caller":"traceutil/trace.go:171","msg":"trace[587803676] linearizableReadLoop","detail":"{readStateIndex:42; appliedIndex:41; }","duration":"138.189127ms","start":"2026-02-25T15:06:21.777131Z","end":"2026-02-25T15:06:21.91532Z","steps":["trace[587803676] 'read index received' (duration: 131.601768ms)","trace[587803676] 'applied index is now lower than readState.Index' (duration: 6.584799ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:06:21.915603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.411961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T15:06:21.915721Z","caller":"traceutil/trace.go:171","msg":"trace[1005916669] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:39; }","duration":"138.629546ms","start":"2026-02-25T15:06:21.77707Z","end":"2026-02-25T15:06:21.9157Z","steps":["trace[1005916669] 'agreement among raft nodes before linearized reading' (duration: 138.33266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:51.092112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591091904610857,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T15:06:51.59324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591091904610857,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T15:06:51.921293Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.337319266s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T15:06:51.921706Z","caller":"traceutil/trace.go:171","msg":"trace[1981152637] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"1.330350319s","start":"2026-02-25T15:06:50.591333Z","end":"2026-02-25T15:06:51.921683Z","steps":["trace[1981152637] 'read index received' (duration: 1.330114414s)","trace[1981152637] 'applied index is now lower than readState.Index' (duration: 234.675µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:06:51.921842Z","caller":"traceutil/trace.go:171","msg":"trace[1105262066] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"1.337946679s","start":"2026-02-25T15:06:50.583858Z","end":"2026-02-25T15:06:51.921805Z","steps":["trace[1105262066] 'process raft request' (duration: 1.337643793s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:51.921888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330535703s","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-25T15:06:51.921927Z","caller":"traceutil/trace.go:171","msg":"trace[840186616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"1.330592624s","start":"2026-02-25T15:06:50.591323Z","end":"2026-02-25T15:06:51.921915Z","steps":["trace[840186616] 'agreement among raft nodes before linearized reading' (duration: 1.330444471s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:51.921985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:06:50.591275Z","time spent":"1.330697486s","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T15:06:51.922594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:06:50.583842Z","time spent":"1.338085971s","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:06:56.237597Z","caller":"traceutil/trace.go:171","msg":"trace[1257153118] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:508; }","duration":"227.431107ms","start":"2026-02-25T15:06:56.010142Z","end":"2026-02-25T15:06:56.237573Z","steps":["trace[1257153118] 'read index received' (duration: 227.109809ms)","trace[1257153118] 'applied index is now lower than readState.Index' (duration: 320.598µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:06:56.237723Z","caller":"traceutil/trace.go:171","msg":"trace[1564162568] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"294.807529ms","start":"2026-02-25T15:06:55.942898Z","end":"2026-02-25T15:06:56.237706Z","steps":["trace[1564162568] 'process raft request' (duration: 294.620026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:56.237776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.616471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:06:56.237751Z","caller":"traceutil/trace.go:171","msg":"trace[350228329] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"297.229559ms","start":"2026-02-25T15:06:55.940489Z","end":"2026-02-25T15:06:56.237719Z","steps":["trace[350228329] 'process raft request' (duration: 296.858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:56.237911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.532685ms","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-25T15:06:56.237921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.594566ms","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-25T15:06:56.237944Z","caller":"traceutil/trace.go:171","msg":"trace[385036640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:492; }","duration":"181.610586ms","start":"2026-02-25T15:06:56.056325Z","end":"2026-02-25T15:06:56.237935Z","steps":["trace[385036640] 'agreement among raft nodes before linearized reading' (duration: 181.526374ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:56.237949Z","caller":"traceutil/trace.go:171","msg":"trace[234285708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:492; }","duration":"181.661677ms","start":"2026-02-25T15:06:56.05628Z","end":"2026-02-25T15:06:56.237942Z","steps":["trace[234285708] 'agreement among raft nodes before linearized reading' (duration: 181.551925ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:56.23781Z","caller":"traceutil/trace.go:171","msg":"trace[656630809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"227.714093ms","start":"2026-02-25T15:06:56.010086Z","end":"2026-02-25T15:06:56.2378Z","steps":["trace[656630809] 'agreement among raft nodes before linearized reading' (duration: 227.620491ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:56.518119Z","caller":"traceutil/trace.go:171","msg":"trace[1029013163] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"275.622886ms","start":"2026-02-25T15:06:56.24247Z","end":"2026-02-25T15:06:56.518093Z","steps":["trace[1029013163] 'process raft request' (duration: 275.437213ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:56.518381Z","caller":"traceutil/trace.go:171","msg":"trace[880770615] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"275.867582ms","start":"2026-02-25T15:06:56.242476Z","end":"2026-02-25T15:06:56.518344Z","steps":["trace[880770615] 'process raft request' (duration: 275.570935ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:58.500151Z","caller":"traceutil/trace.go:171","msg":"trace[1587913678] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:512; }","duration":"490.468757ms","start":"2026-02-25T15:06:58.009659Z","end":"2026-02-25T15:06:58.500127Z","steps":["trace[1587913678] 'read index received' (duration: 490.297194ms)","trace[1587913678] 'applied index is now lower than readState.Index' (duration: 170.533µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:06:58.500278Z","caller":"traceutil/trace.go:171","msg":"trace[415609050] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"530.004236ms","start":"2026-02-25T15:06:57.970265Z","end":"2026-02-25T15:06:58.500269Z","steps":["trace[415609050] 'process raft request' (duration: 529.71585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:58.500383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:06:57.970243Z","time spent":"530.062347ms","remote":"127.0.0.1:46110","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-25T15:06:58.5005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.638269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T15:06:58.500638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.957328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:06:58.500711Z","caller":"traceutil/trace.go:171","msg":"trace[594556473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:495; }","duration":"491.132561ms","start":"2026-02-25T15:06:58.00956Z","end":"2026-02-25T15:06:58.500693Z","steps":["trace[594556473] 'agreement among raft nodes before linearized reading' (duration: 490.963148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:06:58.500755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:06:58.009542Z","time spent":"491.204883ms","remote":"127.0.0.1:45860","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-25T15:06:58.500804Z","caller":"traceutil/trace.go:171","msg":"trace[401797569] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:495; }","duration":"257.804792ms","start":"2026-02-25T15:06:58.242795Z","end":"2026-02-25T15:06:58.500599Z","steps":["trace[401797569] 'agreement among raft nodes before linearized reading' (duration: 257.564687ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:06:58.62056Z","caller":"traceutil/trace.go:171","msg":"trace[935359099] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"115.697945ms","start":"2026-02-25T15:06:58.504829Z","end":"2026-02-25T15:06:58.620527Z","steps":["trace[935359099] 'process raft request' (duration: 115.506561ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:01.93077Z","caller":"traceutil/trace.go:171","msg":"trace[1754936056] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"143.361224ms","start":"2026-02-25T15:07:01.787379Z","end":"2026-02-25T15:07:01.930741Z","steps":["trace[1754936056] 'process raft request' (duration: 93.869677ms)","trace[1754936056] 'compare' (duration: 49.374664ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:07:03.312769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.67818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-25T15:07:03.312908Z","caller":"traceutil/trace.go:171","msg":"trace[256700202] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:566; }","duration":"143.879445ms","start":"2026-02-25T15:07:03.168996Z","end":"2026-02-25T15:07:03.312875Z","steps":["trace[256700202] 'range keys from in-memory index tree' (duration: 143.433686ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:12.870731Z","caller":"traceutil/trace.go:171","msg":"trace[1238175483] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"278.893384ms","start":"2026-02-25T15:07:12.591818Z","end":"2026-02-25T15:07:12.870712Z","steps":["trace[1238175483] 'read index received' (duration: 278.677759ms)","trace[1238175483] 'applied index is now lower than readState.Index' (duration: 214.965µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:12.870834Z","caller":"traceutil/trace.go:171","msg":"trace[998462860] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"321.827073ms","start":"2026-02-25T15:07:12.548968Z","end":"2026-02-25T15:07:12.870795Z","steps":["trace[998462860] 'process raft request' (duration: 321.578307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:12.870974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.044693ms","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-25T15:07:12.871003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:12.548941Z","time spent":"321.974646ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:12.871009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.758916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T15:07:12.871082Z","caller":"traceutil/trace.go:171","msg":"trace[1582373129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:664; }","duration":"171.862119ms","start":"2026-02-25T15:07:12.6992Z","end":"2026-02-25T15:07:12.871062Z","steps":["trace[1582373129] 'agreement among raft nodes before linearized reading' (duration: 171.662514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:12.871096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.286982ms","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-25T15:07:12.871092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.588137ms","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-25T15:07:12.871142Z","caller":"traceutil/trace.go:171","msg":"trace[912913877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:664; }","duration":"279.369005ms","start":"2026-02-25T15:07:12.591764Z","end":"2026-02-25T15:07:12.871133Z","steps":["trace[912913877] 'agreement among raft nodes before linearized reading' (duration: 279.044728ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:12.871013Z","caller":"traceutil/trace.go:171","msg":"trace[287988074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"148.131505ms","start":"2026-02-25T15:07:12.722871Z","end":"2026-02-25T15:07:12.871002Z","steps":["trace[287988074] 'agreement among raft nodes before linearized reading' (duration: 147.996442ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:12.871166Z","caller":"traceutil/trace.go:171","msg":"trace[1772189908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:664; }","duration":"149.700998ms","start":"2026-02-25T15:07:12.721448Z","end":"2026-02-25T15:07:12.871149Z","steps":["trace[1772189908] 'agreement among raft nodes before linearized reading' (duration: 149.456453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.610774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.282646ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-25T15:07:19.61088Z","caller":"traceutil/trace.go:171","msg":"trace[82829868] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"706.427498ms","start":"2026-02-25T15:07:18.904433Z","end":"2026-02-25T15:07:19.61086Z","steps":["trace[82829868] 'read index received' (duration: 155.845676ms)","trace[82829868] 'applied index is now lower than readState.Index' (duration: 550.580462ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:07:19.611076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.632382ms","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-25T15:07:19.611117Z","caller":"traceutil/trace.go:171","msg":"trace[1190912181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:682; }","duration":"706.676773ms","start":"2026-02-25T15:07:18.904428Z","end":"2026-02-25T15:07:19.611104Z","steps":["trace[1190912181] 'agreement among raft nodes before linearized reading' (duration: 706.52316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.611161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:18.904389Z","time spent":"706.760735ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T15:07:19.611159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.761021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T15:07:19.611236Z","caller":"traceutil/trace.go:171","msg":"trace[1396519666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:682; }","duration":"699.857633ms","start":"2026-02-25T15:07:18.911357Z","end":"2026-02-25T15:07:19.611215Z","steps":["trace[1396519666] 'agreement among raft nodes before linearized reading' (duration: 699.628128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.611282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:18.911352Z","time spent":"699.920034ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T15:07:19.611457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.3296ms","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-25T15:07:19.611487Z","caller":"traceutil/trace.go:171","msg":"trace[1396091923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"689.35777ms","start":"2026-02-25T15:07:18.922119Z","end":"2026-02-25T15:07:19.611476Z","steps":["trace[1396091923] 'agreement among raft nodes before linearized reading' (duration: 689.269278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.611515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:18.922087Z","time spent":"689.421532ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T15:07:19.61163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.03769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:07:19.611665Z","caller":"traceutil/trace.go:171","msg":"trace[965008388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"602.085681ms","start":"2026-02-25T15:07:19.009569Z","end":"2026-02-25T15:07:19.611655Z","steps":["trace[965008388] 'agreement among raft nodes before linearized reading' (duration: 602.03423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.6117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.009563Z","time spent":"602.130412ms","remote":"127.0.0.1:45860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:07:19.611774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.971906ms","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-25T15:07:19.611725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.018473ms","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-25T15:07:19.611809Z","caller":"traceutil/trace.go:171","msg":"trace[1759007275] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:682; }","duration":"691.046877ms","start":"2026-02-25T15:07:18.920751Z","end":"2026-02-25T15:07:19.611798Z","steps":["trace[1759007275] 'agreement among raft nodes before linearized reading' (duration: 690.945255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.611841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:18.92073Z","time spent":"691.104608ms","remote":"127.0.0.1:46110","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":"info","ts":"2026-02-25T15:07:19.61183Z","caller":"traceutil/trace.go:171","msg":"trace[1640621666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:682; }","duration":"689.170367ms","start":"2026-02-25T15:07:18.922641Z","end":"2026-02-25T15:07:19.611811Z","steps":["trace[1640621666] 'agreement among raft nodes before linearized reading' (duration: 688.356169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:19.611898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:18.922621Z","time spent":"689.267648ms","remote":"127.0.0.1:46110","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-25T15:07:20.005245Z","caller":"traceutil/trace.go:171","msg":"trace[7647525] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"388.750724ms","start":"2026-02-25T15:07:19.61647Z","end":"2026-02-25T15:07:20.00522Z","steps":["trace[7647525] 'process raft request' (duration: 388.538849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:20.005381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.616448Z","time spent":"388.865257ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:07:20.175166Z","caller":"traceutil/trace.go:171","msg":"trace[2095168383] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"558.402955ms","start":"2026-02-25T15:07:19.616732Z","end":"2026-02-25T15:07:20.175135Z","steps":["trace[2095168383] 'process raft request' (duration: 558.256841ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:20.175158Z","caller":"traceutil/trace.go:171","msg":"trace[292002615] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"558.450365ms","start":"2026-02-25T15:07:19.616659Z","end":"2026-02-25T15:07:20.17511Z","steps":["trace[292002615] 'process raft request' (duration: 558.099357ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:20.175148Z","caller":"traceutil/trace.go:171","msg":"trace[1373968153] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"558.060117ms","start":"2026-02-25T15:07:19.617051Z","end":"2026-02-25T15:07:20.175111Z","steps":["trace[1373968153] 'process raft request' (duration: 558.017716ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:20.175266Z","caller":"traceutil/trace.go:171","msg":"trace[1772436065] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"558.218261ms","start":"2026-02-25T15:07:19.616989Z","end":"2026-02-25T15:07:20.175207Z","steps":["trace[1772436065] 'process raft request' (duration: 558.042006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:20.175317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.616727Z","time spent":"558.512027ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:20.175346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.61664Z","time spent":"558.606549ms","remote":"127.0.0.1:46110","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-25T15:07:20.175392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.617046Z","time spent":"558.237031ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:20.175461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:19.616981Z","time spent":"558.374014ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:07:22.499651Z","caller":"traceutil/trace.go:171","msg":"trace[1393127065] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:711; }","duration":"320.244949ms","start":"2026-02-25T15:07:22.179382Z","end":"2026-02-25T15:07:22.499627Z","steps":["trace[1393127065] 'read index received' (duration: 320.056565ms)","trace[1393127065] 'applied index is now lower than readState.Index' (duration: 187.574µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:22.499691Z","caller":"traceutil/trace.go:171","msg":"trace[1066625602] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"485.725486ms","start":"2026-02-25T15:07:22.013938Z","end":"2026-02-25T15:07:22.499664Z","steps":["trace[1066625602] 'process raft request' (duration: 485.555483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:22.499823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.013912Z","time spent":"485.835019ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:22.499831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.686627ms","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-25T15:07:22.499858Z","caller":"traceutil/trace.go:171","msg":"trace[1830024479] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:688; }","duration":"319.725038ms","start":"2026-02-25T15:07:22.180127Z","end":"2026-02-25T15:07:22.499852Z","steps":["trace[1830024479] 'agreement among raft nodes before linearized reading' (duration: 319.631996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:22.499856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.466223ms","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-25T15:07:22.499918Z","caller":"traceutil/trace.go:171","msg":"trace[2127942221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:688; }","duration":"320.556456ms","start":"2026-02-25T15:07:22.179342Z","end":"2026-02-25T15:07:22.499899Z","steps":["trace[2127942221] 'agreement among raft nodes before linearized reading' (duration: 320.379752ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:22.499939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.905421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-25T15:07:22.499951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.179322Z","time spent":"320.623547ms","remote":"127.0.0.1:46110","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-25T15:07:22.499852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.250167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:07:22.499976Z","caller":"traceutil/trace.go:171","msg":"trace[1036184749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:688; }","duration":"319.954652ms","start":"2026-02-25T15:07:22.180011Z","end":"2026-02-25T15:07:22.499965Z","steps":["trace[1036184749] 'agreement among raft nodes before linearized reading' (duration: 319.839299ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:22.500011Z","caller":"traceutil/trace.go:171","msg":"trace[518609770] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:688; }","duration":"229.463522ms","start":"2026-02-25T15:07:22.270533Z","end":"2026-02-25T15:07:22.499997Z","steps":["trace[518609770] 'agreement among raft nodes before linearized reading' (duration: 229.231437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:22.500012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.180002Z","time spent":"320.003594ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T15:07:22.499831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.074995ms","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-25T15:07:22.500196Z","caller":"traceutil/trace.go:171","msg":"trace[549604333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:688; }","duration":"320.464954ms","start":"2026-02-25T15:07:22.179721Z","end":"2026-02-25T15:07:22.500186Z","steps":["trace[549604333] 'agreement among raft nodes before linearized reading' (duration: 320.021754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:22.500241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.179713Z","time spent":"320.517855ms","remote":"127.0.0.1:46110","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-25T15:07:22.499877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.180105Z","time spent":"319.768208ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T15:07:23.000988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.12836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:07:23.001051Z","caller":"traceutil/trace.go:171","msg":"trace[374319928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"317.239342ms","start":"2026-02-25T15:07:22.683798Z","end":"2026-02-25T15:07:23.001038Z","steps":["trace[374319928] 'range keys from in-memory index tree' (duration: 317.069758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:23.001091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:22.68378Z","time spent":"317.304514ms","remote":"127.0.0.1:45860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:07:44.30235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.394193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:07:44.30274Z","caller":"traceutil/trace.go:171","msg":"trace[1803077855] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"837.055394ms","start":"2026-02-25T15:07:43.465659Z","end":"2026-02-25T15:07:44.302715Z","steps":["trace[1803077855] 'process raft request' (duration: 364.153609ms)","trace[1803077855] 'compare' (duration: 472.279691ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:07:44.303073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:43.465643Z","time spent":"837.3802ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:07:44.309653Z","caller":"traceutil/trace.go:171","msg":"trace[1290773951] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"297.885146ms","start":"2026-02-25T15:07:44.011753Z","end":"2026-02-25T15:07:44.309638Z","steps":["trace[1290773951] 'read index received' (duration: 297.745733ms)","trace[1290773951] 'applied index is now lower than readState.Index' (duration: 138.563µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:44.309934Z","caller":"traceutil/trace.go:171","msg":"trace[1730871090] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"592.214731ms","start":"2026-02-25T15:07:43.717708Z","end":"2026-02-25T15:07:44.309922Z","steps":["trace[1730871090] 'process raft request' (duration: 591.855564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:44.310025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:43.717677Z","time spent":"592.295753ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:44.310143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.397087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:07:44.310192Z","caller":"traceutil/trace.go:171","msg":"trace[427063716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"298.483519ms","start":"2026-02-25T15:07:44.011696Z","end":"2026-02-25T15:07:44.31018Z","steps":["trace[427063716] 'agreement among raft nodes before linearized reading' (duration: 298.413077ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:44.832484Z","caller":"traceutil/trace.go:171","msg":"trace[327086223] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"122.66799ms","start":"2026-02-25T15:07:44.709785Z","end":"2026-02-25T15:07:44.832453Z","steps":["trace[327086223] 'process raft request' (duration: 122.397534ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:46.889834Z","caller":"traceutil/trace.go:171","msg":"trace[1512434989] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"205.37101ms","start":"2026-02-25T15:07:46.684434Z","end":"2026-02-25T15:07:46.889805Z","steps":["trace[1512434989] 'read index received' (duration: 205.194496ms)","trace[1512434989] 'applied index is now lower than readState.Index' (duration: 175.034µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:07:46.889956Z","caller":"traceutil/trace.go:171","msg":"trace[1929399718] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"503.801796ms","start":"2026-02-25T15:07:46.386123Z","end":"2026-02-25T15:07:46.889925Z","steps":["trace[1929399718] 'process raft request' (duration: 503.432838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:46.890109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:07:46.38609Z","time spent":"503.939679ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:07:46.890138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.689927ms","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-25T15:07:46.8902Z","caller":"traceutil/trace.go:171","msg":"trace[522661611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:762; }","duration":"205.81155ms","start":"2026-02-25T15:07:46.68437Z","end":"2026-02-25T15:07:46.890182Z","steps":["trace[522661611] 'agreement among raft nodes before linearized reading' (duration: 205.602175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:46.890605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.017041ms","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-25T15:07:46.890754Z","caller":"traceutil/trace.go:171","msg":"trace[1972528647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:762; }","duration":"191.160245ms","start":"2026-02-25T15:07:46.699525Z","end":"2026-02-25T15:07:46.890685Z","steps":["trace[1972528647] 'agreement among raft nodes before linearized reading' (duration: 190.674244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:07:46.891208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.673929ms","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-25T15:07:46.891271Z","caller":"traceutil/trace.go:171","msg":"trace[934087076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:762; }","duration":"197.778641ms","start":"2026-02-25T15:07:46.693478Z","end":"2026-02-25T15:07:46.891256Z","steps":["trace[934087076] 'agreement among raft nodes before linearized reading' (duration: 196.557905ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:47.034355Z","caller":"traceutil/trace.go:171","msg":"trace[1741372852] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"137.923268ms","start":"2026-02-25T15:07:46.896418Z","end":"2026-02-25T15:07:47.034341Z","steps":["trace[1741372852] 'process raft request' (duration: 137.614531ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:47.034348Z","caller":"traceutil/trace.go:171","msg":"trace[2133896720] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"137.631342ms","start":"2026-02-25T15:07:46.896687Z","end":"2026-02-25T15:07:47.034285Z","steps":["trace[2133896720] 'process raft request' (duration: 137.503849ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:47.034549Z","caller":"traceutil/trace.go:171","msg":"trace[463827944] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"137.687363ms","start":"2026-02-25T15:07:46.896853Z","end":"2026-02-25T15:07:47.034541Z","steps":["trace[463827944] 'process raft request' (duration: 137.386427ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:07:47.034883Z","caller":"traceutil/trace.go:171","msg":"trace[953481524] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"135.68956ms","start":"2026-02-25T15:07:46.899174Z","end":"2026-02-25T15:07:47.034863Z","steps":["trace[953481524] 'process raft request' (duration: 135.322972ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:01.38024Z","caller":"traceutil/trace.go:171","msg":"trace[105301793] linearizableReadLoop","detail":"{readStateIndex:888; appliedIndex:887; }","duration":"288.075617ms","start":"2026-02-25T15:08:01.092142Z","end":"2026-02-25T15:08:01.380217Z","steps":["trace[105301793] 'read index received' (duration: 287.905563ms)","trace[105301793] 'applied index is now lower than readState.Index' (duration: 169.134µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:08:01.380376Z","caller":"traceutil/trace.go:171","msg":"trace[2100312714] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"378.19872ms","start":"2026-02-25T15:08:01.002154Z","end":"2026-02-25T15:08:01.380353Z","steps":["trace[2100312714] 'process raft request' (duration: 377.935994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:01.380489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:01.002132Z","time spent":"378.281132ms","remote":"127.0.0.1:46110","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-25T15:08:01.380584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.397625ms","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-25T15:08:01.380659Z","caller":"traceutil/trace.go:171","msg":"trace[1712105723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:853; }","duration":"288.500757ms","start":"2026-02-25T15:08:01.092141Z","end":"2026-02-25T15:08:01.380642Z","steps":["trace[1712105723] 'agreement among raft nodes before linearized reading' (duration: 288.304072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:01.380834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.113758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-25T15:08:01.38093Z","caller":"traceutil/trace.go:171","msg":"trace[940626906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:853; }","duration":"283.19907ms","start":"2026-02-25T15:08:01.097691Z","end":"2026-02-25T15:08:01.38089Z","steps":["trace[940626906] 'agreement among raft nodes before linearized reading' (duration: 283.079348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:01.380884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.726512ms","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-25T15:08:01.381052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.704706ms","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-25T15:08:01.381082Z","caller":"traceutil/trace.go:171","msg":"trace[175538479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:853; }","duration":"288.958027ms","start":"2026-02-25T15:08:01.092108Z","end":"2026-02-25T15:08:01.381066Z","steps":["trace[175538479] 'agreement among raft nodes before linearized reading' (duration: 288.689511ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:01.381092Z","caller":"traceutil/trace.go:171","msg":"trace[1763890314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:853; }","duration":"285.762177ms","start":"2026-02-25T15:08:01.095316Z","end":"2026-02-25T15:08:01.381078Z","steps":["trace[1763890314] 'agreement among raft nodes before linearized reading' (duration: 285.659524ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:19.243933Z","caller":"traceutil/trace.go:171","msg":"trace[1754851991] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:961; }","duration":"356.215674ms","start":"2026-02-25T15:08:18.887683Z","end":"2026-02-25T15:08:19.243898Z","steps":["trace[1754851991] 'read index received' (duration: 324.176466ms)","trace[1754851991] 'applied index is now lower than readState.Index' (duration: 32.037498ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:08:19.244152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.298199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:08:19.244221Z","caller":"traceutil/trace.go:171","msg":"trace[1738277840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:923; }","duration":"234.41026ms","start":"2026-02-25T15:08:19.009793Z","end":"2026-02-25T15:08:19.244203Z","steps":["trace[1738277840] 'agreement among raft nodes before linearized reading' (duration: 234.293908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:19.244151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.445479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T15:08:19.244364Z","caller":"traceutil/trace.go:171","msg":"trace[1008666331] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:923; }","duration":"356.701034ms","start":"2026-02-25T15:08:18.887639Z","end":"2026-02-25T15:08:19.24434Z","steps":["trace[1008666331] 'agreement among raft nodes before linearized reading' (duration: 356.450169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:19.24445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:18.887621Z","time spent":"356.808356ms","remote":"127.0.0.1:46016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:08:20.806785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.770659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:08:20.807147Z","caller":"traceutil/trace.go:171","msg":"trace[1348315221] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"804.326138ms","start":"2026-02-25T15:08:20.002751Z","end":"2026-02-25T15:08:20.807077Z","steps":["trace[1348315221] 'process raft request' (duration: 184.173351ms)","trace[1348315221] 'compare' (duration: 619.267628ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:08:20.807304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:20.002732Z","time spent":"804.546322ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T15:08:21.338158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.325315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T15:08:21.338445Z","caller":"traceutil/trace.go:171","msg":"trace[1572219374] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:972; }","duration":"327.698573ms","start":"2026-02-25T15:08:21.010733Z","end":"2026-02-25T15:08:21.338432Z","steps":["trace[1572219374] 'read index received' (duration: 57.03396ms)","trace[1572219374] 'applied index is now lower than readState.Index' (duration: 270.663673ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:08:21.33847Z","caller":"traceutil/trace.go:171","msg":"trace[841540512] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"525.920025ms","start":"2026-02-25T15:08:20.812515Z","end":"2026-02-25T15:08:21.338435Z","steps":["trace[841540512] 'process raft request' (duration: 255.251022ms)","trace[841540512] 'compare' (duration: 270.155072ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:08:21.338638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:20.812501Z","time spent":"526.064178ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T15:08:21.338739Z","caller":"traceutil/trace.go:171","msg":"trace[684548845] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"515.398351ms","start":"2026-02-25T15:08:20.823332Z","end":"2026-02-25T15:08:21.33873Z","steps":["trace[684548845] 'process raft request' (duration: 515.023113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:21.339302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.557841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:08:21.339355Z","caller":"traceutil/trace.go:171","msg":"trace[2040317785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:935; }","duration":"328.647514ms","start":"2026-02-25T15:08:21.010694Z","end":"2026-02-25T15:08:21.339342Z","steps":["trace[2040317785] 'agreement among raft nodes before linearized reading' (duration: 328.574002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:21.339402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:21.010674Z","time spent":"328.715105ms","remote":"127.0.0.1:45860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T15:08:21.340215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:20.823312Z","time spent":"515.457063ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:08:23.892324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.668946ms","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-25T15:08:23.892403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.993726ms","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-25T15:08:23.892519Z","caller":"traceutil/trace.go:171","msg":"trace[1735459331] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:941; }","duration":"215.859482ms","start":"2026-02-25T15:08:23.676567Z","end":"2026-02-25T15:08:23.892426Z","steps":["trace[1735459331] 'range keys from in-memory index tree' (duration: 215.510152ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:23.892574Z","caller":"traceutil/trace.go:171","msg":"trace[1902823112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:941; }","duration":"212.16397ms","start":"2026-02-25T15:08:23.680377Z","end":"2026-02-25T15:08:23.892541Z","steps":["trace[1902823112] 'range keys from in-memory index tree' (duration: 211.831101ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:23.89261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.027742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-25T15:08:23.892658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.982625ms","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-25T15:08:23.892687Z","caller":"traceutil/trace.go:171","msg":"trace[355081928] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:941; }","duration":"153.396681ms","start":"2026-02-25T15:08:23.739272Z","end":"2026-02-25T15:08:23.892669Z","steps":["trace[355081928] 'range keys from in-memory index tree' (duration: 152.879658ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:23.892736Z","caller":"traceutil/trace.go:171","msg":"trace[836168401] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:941; }","duration":"269.105708ms","start":"2026-02-25T15:08:23.623613Z","end":"2026-02-25T15:08:23.892718Z","steps":["trace[836168401] 'range keys from in-memory index tree' (duration: 268.839482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:23.892788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.27525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T15:08:23.892857Z","caller":"traceutil/trace.go:171","msg":"trace[490257614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:941; }","duration":"154.370692ms","start":"2026-02-25T15:08:23.738467Z","end":"2026-02-25T15:08:23.892838Z","steps":["trace[490257614] 'range keys from in-memory index tree' (duration: 153.985354ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:23.894154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.105302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T15:08:23.894193Z","caller":"traceutil/trace.go:171","msg":"trace[1957732395] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:941; }","duration":"309.190014ms","start":"2026-02-25T15:08:23.584994Z","end":"2026-02-25T15:08:23.894184Z","steps":["trace[1957732395] 'count revisions from in-memory index tree' (duration: 307.269582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:08:23.89437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:23.58497Z","time spent":"309.388628ms","remote":"127.0.0.1:45620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-25T15:08:29.259309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.795079ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-25T15:08:29.259637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.367376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:08:29.259726Z","caller":"traceutil/trace.go:171","msg":"trace[636638365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:974; }","duration":"251.485169ms","start":"2026-02-25T15:08:29.008218Z","end":"2026-02-25T15:08:29.259703Z","steps":["trace[636638365] 'agreement among raft nodes before linearized reading' (duration: 251.333765ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:29.259819Z","caller":"traceutil/trace.go:171","msg":"trace[461405588] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1014; }","duration":"251.160541ms","start":"2026-02-25T15:08:29.008248Z","end":"2026-02-25T15:08:29.259408Z","steps":["trace[461405588] 'read index received' (duration: 11.238939ms)","trace[461405588] 'applied index is now lower than readState.Index' (duration: 239.919792ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:08:33.358579Z","caller":"traceutil/trace.go:171","msg":"trace[525590020] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"243.790698ms","start":"2026-02-25T15:08:33.114775Z","end":"2026-02-25T15:08:33.358565Z","steps":["trace[525590020] 'process raft request' (duration: 243.41847ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:08:33.358424Z","caller":"traceutil/trace.go:171","msg":"trace[652137029] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"240.994817ms","start":"2026-02-25T15:08:33.117408Z","end":"2026-02-25T15:08:33.358403Z","steps":["trace[652137029] 'read index received' (duration: 240.799873ms)","trace[652137029] 'applied index is now lower than readState.Index' (duration: 194.004µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T15:08:33.358814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.391975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:08:33.35886Z","caller":"traceutil/trace.go:171","msg":"trace[1500886594] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:997; }","duration":"241.462717ms","start":"2026-02-25T15:08:33.117385Z","end":"2026-02-25T15:08:33.358848Z","steps":["trace[1500886594] 'agreement among raft nodes before linearized reading' (duration: 241.372335ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:11:32.989998Z","caller":"traceutil/trace.go:171","msg":"trace[1516783524] transaction","detail":"{read_only:false; response_revision:1763; number_of_response:1; }","duration":"177.003359ms","start":"2026-02-25T15:11:32.81297Z","end":"2026-02-25T15:11:32.989973Z","steps":["trace[1516783524] 'process raft request' (duration: 176.855766ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:11:33.16982Z","caller":"traceutil/trace.go:171","msg":"trace[412487668] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"354.941239ms","start":"2026-02-25T15:11:32.81485Z","end":"2026-02-25T15:11:33.169791Z","steps":["trace[412487668] 'process raft request' (duration: 354.731644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:11:33.170009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:11:32.814836Z","time spent":"355.067682ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T15:11:33.170137Z","caller":"traceutil/trace.go:171","msg":"trace[1542645604] linearizableReadLoop","detail":"{readStateIndex:1843; appliedIndex:1840; }","duration":"339.462429ms","start":"2026-02-25T15:11:32.830633Z","end":"2026-02-25T15:11:33.170096Z","steps":["trace[1542645604] 'read index received' (duration: 159.185047ms)","trace[1542645604] 'applied index is now lower than readState.Index' (duration: 180.274662ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T15:11:33.170192Z","caller":"traceutil/trace.go:171","msg":"trace[2035747719] transaction","detail":"{read_only:false; response_revision:1765; number_of_response:1; }","duration":"354.824037ms","start":"2026-02-25T15:11:32.815353Z","end":"2026-02-25T15:11:33.170177Z","steps":["trace[2035747719] 'process raft request' (duration: 354.396697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:11:33.17027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:11:32.815334Z","time spent":"354.895738ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T15:11:33.170478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.355906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-02-25T15:11:33.170495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.471815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T15:11:33.170515Z","caller":"traceutil/trace.go:171","msg":"trace[1012881225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1765; }","duration":"339.436767ms","start":"2026-02-25T15:11:32.831067Z","end":"2026-02-25T15:11:33.170504Z","steps":["trace[1012881225] 'agreement among raft nodes before linearized reading' (duration: 339.207902ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T15:11:33.170555Z","caller":"traceutil/trace.go:171","msg":"trace[1236769118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1765; }","duration":"160.565787ms","start":"2026-02-25T15:11:33.009969Z","end":"2026-02-25T15:11:33.170535Z","steps":["trace[1236769118] 'agreement among raft nodes before linearized reading' (duration: 160.459215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:11:33.170557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:11:32.831057Z","time spent":"339.492039ms","remote":"127.0.0.1:46110","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":"warn","ts":"2026-02-25T15:11:33.170523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.848507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-25T15:11:33.170721Z","caller":"traceutil/trace.go:171","msg":"trace[496226514] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1765; }","duration":"340.086952ms","start":"2026-02-25T15:11:32.830607Z","end":"2026-02-25T15:11:33.170694Z","steps":["trace[496226514] 'agreement among raft nodes before linearized reading' (duration: 339.659353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T15:11:33.17078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:11:32.830593Z","time spent":"340.173774ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}