{"level":"warn","ts":"2026-02-18T19:48:01.885913Z","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-18T19:48:01.886051Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.227:2380","--initial-cluster=instance=https://162.253.55.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.227: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-18T19:48:01.886153Z","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-18T19:48:01.886163Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.227:2380"]} {"level":"info","ts":"2026-02-18T19:48:01.886188Z","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-18T19:48:01.88681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"]} {"level":"info","ts":"2026-02-18T19:48:01.886904Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.227: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-18T19:48:01.894065Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.884768ms"} {"level":"info","ts":"2026-02-18T19:48:01.912457Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd37ed2859641e3","cluster-id":"47d0f4f0a1c3b0a9"} {"level":"info","ts":"2026-02-18T19:48:01.91272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T19:48:01.912865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 0"} {"level":"info","ts":"2026-02-18T19:48:01.912922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd37ed2859641e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T19:48:01.91307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 1"} {"level":"info","ts":"2026-02-18T19:48:01.91338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"} {"level":"warn","ts":"2026-02-18T19:48:01.921517Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T19:48:01.923022Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T19:48:01.924297Z","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-18T19:48:01.930049Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd37ed2859641e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T19:48:01.930401Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd37ed2859641e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T19:48:01.930604Z","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-18T19:48:01.930638Z","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-18T19:48:01.930703Z","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-18T19:48:01.931217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"} {"level":"info","ts":"2026-02-18T19:48:01.931348Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","added-peer-id":"9bd37ed2859641e3","added-peer-peer-urls":["https://162.253.55.227:2380"]} {"level":"info","ts":"2026-02-18T19:48:01.935366Z","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-18T19:48:01.936222Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.227:2380"} {"level":"info","ts":"2026-02-18T19:48:01.936241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.227:2380"} {"level":"info","ts":"2026-02-18T19:48:01.937265Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd37ed2859641e3","initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T19:48:01.937289Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T19:48:02.217763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T19:48:02.218006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T19:48:02.218081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgPreVoteResp from 9bd37ed2859641e3 at term 1"} {"level":"info","ts":"2026-02-18T19:48:02.218143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became candidate at term 2"} {"level":"info","ts":"2026-02-18T19:48:02.218196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgVoteResp from 9bd37ed2859641e3 at term 2"} {"level":"info","ts":"2026-02-18T19:48:02.218239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became leader at term 2"} {"level":"info","ts":"2026-02-18T19:48:02.218306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd37ed2859641e3 elected leader 9bd37ed2859641e3 at term 2"} {"level":"info","ts":"2026-02-18T19:48:02.221787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd37ed2859641e3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.227:2379]}","request-path":"/0/members/9bd37ed2859641e3/attributes","cluster-id":"47d0f4f0a1c3b0a9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T19:48:02.221879Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:48:02.222286Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:48:02.222605Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T19:48:02.222791Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T19:48:02.222858Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T19:48:02.224392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-18T19:48:02.228839Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:48:02.228978Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:48:02.229049Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T19:48:02.239903Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.227:2379"} {"level":"info","ts":"2026-02-18T19:48:28.378363Z","caller":"traceutil/trace.go:171","msg":"trace[1700943670] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"259.00215ms","start":"2026-02-18T19:48:28.119334Z","end":"2026-02-18T19:48:28.378336Z","steps":["trace[1700943670] 'process raft request' (duration: 258.832356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:39.046137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.217337ms","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-18T19:48:39.046216Z","caller":"traceutil/trace.go:171","msg":"trace[1900364166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"111.304589ms","start":"2026-02-18T19:48:38.934901Z","end":"2026-02-18T19:48:39.046205Z","steps":["trace[1900364166] 'range keys from in-memory index tree' (duration: 111.163476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:39.046403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.567628ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:48:39.046442Z","caller":"traceutil/trace.go:171","msg":"trace[649422324] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:529; }","duration":"120.620909ms","start":"2026-02-18T19:48:38.925815Z","end":"2026-02-18T19:48:39.046436Z","steps":["trace[649422324] 'range keys from in-memory index tree' (duration: 120.559668ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:39.364108Z","caller":"traceutil/trace.go:171","msg":"trace[1757887980] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"285.897617ms","start":"2026-02-18T19:48:39.078169Z","end":"2026-02-18T19:48:39.364067Z","steps":["trace[1757887980] 'process raft request' (duration: 285.745294ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:39.709159Z","caller":"traceutil/trace.go:171","msg":"trace[88650778] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:545; }","duration":"625.449187ms","start":"2026-02-18T19:48:39.083681Z","end":"2026-02-18T19:48:39.709131Z","steps":["trace[88650778] 'read index received' (duration: 280.121094ms)","trace[88650778] 'applied index is now lower than readState.Index' (duration: 345.327053ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:48:39.70928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.573631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:48:39.709312Z","caller":"traceutil/trace.go:171","msg":"trace[1586812719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"625.632092ms","start":"2026-02-18T19:48:39.08367Z","end":"2026-02-18T19:48:39.709302Z","steps":["trace[1586812719] 'agreement among raft nodes before linearized reading' (duration: 625.55819ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:39.709292Z","caller":"traceutil/trace.go:171","msg":"trace[1272732520] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"629.536655ms","start":"2026-02-18T19:48:39.079726Z","end":"2026-02-18T19:48:39.709263Z","steps":["trace[1272732520] 'process raft request' (duration: 591.647821ms)","trace[1272732520] 'compare' (duration: 37.156017ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:48:39.709348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:39.083665Z","time spent":"625.675322ms","remote":"127.0.0.1:55660","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-18T19:48:39.709588Z","caller":"traceutil/trace.go:171","msg":"trace[183318013] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"629.80186ms","start":"2026-02-18T19:48:39.079774Z","end":"2026-02-18T19:48:39.709575Z","steps":["trace[183318013] 'process raft request' (duration: 629.190867ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:39.709639Z","caller":"traceutil/trace.go:171","msg":"trace[1868349554] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"623.71998ms","start":"2026-02-18T19:48:39.085908Z","end":"2026-02-18T19:48:39.709627Z","steps":["trace[1868349554] 'process raft request' (duration: 623.155468ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:39.709942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:39.07972Z","time spent":"629.662008ms","remote":"127.0.0.1:55948","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-18T19:48:39.709987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:39.079768Z","time spent":"629.846142ms","remote":"127.0.0.1:55948","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-18T19:48:39.710095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:39.0859Z","time spent":"623.811052ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:48:45.041063Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895009,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T19:48:45.068555Z","caller":"traceutil/trace.go:171","msg":"trace[138228406] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"528.505005ms","start":"2026-02-18T19:48:44.54003Z","end":"2026-02-18T19:48:45.068535Z","steps":["trace[138228406] 'read index received' (duration: 528.268ms)","trace[138228406] 'applied index is now lower than readState.Index' (duration: 236.145µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:48:45.068649Z","caller":"traceutil/trace.go:171","msg":"trace[1159714123] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"751.507073ms","start":"2026-02-18T19:48:44.317134Z","end":"2026-02-18T19:48:45.068641Z","steps":["trace[1159714123] 'process raft request' (duration: 751.242518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:45.06875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:44.317105Z","time spent":"751.565984ms","remote":"127.0.0.1:55856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:48:45.069067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.031156ms","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-18T19:48:45.06914Z","caller":"traceutil/trace.go:171","msg":"trace[914607884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"529.140639ms","start":"2026-02-18T19:48:44.539984Z","end":"2026-02-18T19:48:45.069125Z","steps":["trace[914607884] 'agreement among raft nodes before linearized reading' (duration: 528.985985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:45.069168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:44.539963Z","time spent":"529.19936ms","remote":"127.0.0.1:55948","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-18T19:48:47.894129Z","caller":"traceutil/trace.go:171","msg":"trace[259562592] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"149.959889ms","start":"2026-02-18T19:48:47.744129Z","end":"2026-02-18T19:48:47.894088Z","steps":["trace[259562592] 'read index received' (duration: 146.73132ms)","trace[259562592] 'applied index is now lower than readState.Index' (duration: 3.227429ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:48:47.894429Z","caller":"traceutil/trace.go:171","msg":"trace[1611476937] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"246.688085ms","start":"2026-02-18T19:48:47.647733Z","end":"2026-02-18T19:48:47.894421Z","steps":["trace[1611476937] 'process raft request' (duration: 243.184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:47.894752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.604333ms","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-18T19:48:47.894783Z","caller":"traceutil/trace.go:171","msg":"trace[1289826787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"150.676924ms","start":"2026-02-18T19:48:47.744097Z","end":"2026-02-18T19:48:47.894774Z","steps":["trace[1289826787] 'agreement among raft nodes before linearized reading' (duration: 150.49605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:47.899785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.994865ms","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-18T19:48:47.899825Z","caller":"traceutil/trace.go:171","msg":"trace[1554794956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"127.061976ms","start":"2026-02-18T19:48:47.77275Z","end":"2026-02-18T19:48:47.899812Z","steps":["trace[1554794956] 'agreement among raft nodes before linearized reading' (duration: 126.893653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:47.900246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.351622ms","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-18T19:48:47.900273Z","caller":"traceutil/trace.go:171","msg":"trace[1026545499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"127.433645ms","start":"2026-02-18T19:48:47.772833Z","end":"2026-02-18T19:48:47.900266Z","steps":["trace[1026545499] 'agreement among raft nodes before linearized reading' (duration: 127.338203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:55.748957Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895221,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T19:48:55.789849Z","caller":"traceutil/trace.go:171","msg":"trace[1943224372] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"641.682525ms","start":"2026-02-18T19:48:55.148143Z","end":"2026-02-18T19:48:55.789826Z","steps":["trace[1943224372] 'process raft request' (duration: 641.567762ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:55.78997Z","caller":"traceutil/trace.go:171","msg":"trace[1177274581] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:671; }","duration":"541.078746ms","start":"2026-02-18T19:48:55.248872Z","end":"2026-02-18T19:48:55.78995Z","steps":["trace[1177274581] 'read index received' (duration: 541.071335ms)","trace[1177274581] 'applied index is now lower than readState.Index' (duration: 6.331µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:48:55.790105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:55.148132Z","time spent":"641.755937ms","remote":"127.0.0.1:55740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:48:55.790277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.387932ms","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-18T19:48:55.790371Z","caller":"traceutil/trace.go:171","msg":"trace[804120494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"541.499644ms","start":"2026-02-18T19:48:55.248864Z","end":"2026-02-18T19:48:55.790364Z","steps":["trace[804120494] 'agreement among raft nodes before linearized reading' (duration: 541.175167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:55.790411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:55.248814Z","time spent":"541.589886ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T19:48:55.950292Z","caller":"traceutil/trace.go:171","msg":"trace[1061704790] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"189.727483ms","start":"2026-02-18T19:48:55.76053Z","end":"2026-02-18T19:48:55.950257Z","steps":["trace[1061704790] 'process raft request' (duration: 189.627851ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:55.950359Z","caller":"traceutil/trace.go:171","msg":"trace[777513904] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:672; }","duration":"160.286661ms","start":"2026-02-18T19:48:55.790026Z","end":"2026-02-18T19:48:55.950312Z","steps":["trace[777513904] 'read index received' (duration: 160.27921ms)","trace[777513904] 'applied index is now lower than readState.Index' (duration: 6.151µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:48:55.950538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.002795ms","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-18T19:48:55.95057Z","caller":"traceutil/trace.go:171","msg":"trace[2122627851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:651; }","duration":"549.098398ms","start":"2026-02-18T19:48:55.401462Z","end":"2026-02-18T19:48:55.95056Z","steps":["trace[2122627851] 'agreement among raft nodes before linearized reading' (duration: 548.952825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:48:55.950605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.718269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T19:48:55.950605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:48:55.401447Z","time spent":"549.150259ms","remote":"127.0.0.1:55948","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":"info","ts":"2026-02-18T19:48:55.950639Z","caller":"traceutil/trace.go:171","msg":"trace[1265057515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"214.7873ms","start":"2026-02-18T19:48:55.735846Z","end":"2026-02-18T19:48:55.950633Z","steps":["trace[1265057515] 'agreement among raft nodes before linearized reading' (duration: 214.730629ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:48:55.953749Z","caller":"traceutil/trace.go:171","msg":"trace[753077911] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"156.552321ms","start":"2026-02-18T19:48:55.797188Z","end":"2026-02-18T19:48:55.95374Z","steps":["trace[753077911] 'process raft request' (duration: 156.46586ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:01.571368Z","caller":"traceutil/trace.go:171","msg":"trace[1789200216] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"341.44191ms","start":"2026-02-18T19:49:01.229912Z","end":"2026-02-18T19:49:01.571354Z","steps":["trace[1789200216] 'process raft request' (duration: 341.340748ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:01.571474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.229897Z","time spent":"341.517101ms","remote":"127.0.0.1:55842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4129,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:02.188737Z","caller":"traceutil/trace.go:171","msg":"trace[1252361920] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"955.840284ms","start":"2026-02-18T19:49:01.23288Z","end":"2026-02-18T19:49:02.18872Z","steps":["trace[1252361920] 'process raft request' (duration: 955.376394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.18887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.232864Z","time spent":"955.940576ms","remote":"127.0.0.1:56152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:02.193529Z","caller":"traceutil/trace.go:171","msg":"trace[881572045] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"615.402336ms","start":"2026-02-18T19:49:01.578109Z","end":"2026-02-18T19:49:02.193511Z","steps":["trace[881572045] 'process raft request' (duration: 615.293414ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:02.19355Z","caller":"traceutil/trace.go:171","msg":"trace[1409040060] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:694; }","duration":"216.976806ms","start":"2026-02-18T19:49:01.976562Z","end":"2026-02-18T19:49:02.193539Z","steps":["trace[1409040060] 'read index received' (duration: 212.141043ms)","trace[1409040060] 'applied index is now lower than readState.Index' (duration: 4.835273ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:02.193644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.578104Z","time spent":"615.477337ms","remote":"127.0.0.1:55856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:02.193722Z","caller":"traceutil/trace.go:171","msg":"trace[1544512636] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"615.512398ms","start":"2026-02-18T19:49:01.578203Z","end":"2026-02-18T19:49:02.193715Z","steps":["trace[1544512636] 'process raft request' (duration: 615.240172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.193771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.578198Z","time spent":"615.542239ms","remote":"127.0.0.1:55856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:02.193909Z","caller":"traceutil/trace.go:171","msg":"trace[24984944] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"613.249319ms","start":"2026-02-18T19:49:01.580653Z","end":"2026-02-18T19:49:02.193902Z","steps":["trace[24984944] 'process raft request' (duration: 612.847881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.193942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.580643Z","time spent":"613.28179ms","remote":"127.0.0.1:55842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4481,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:02.194027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.463717ms","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-18T19:49:02.194046Z","caller":"traceutil/trace.go:171","msg":"trace[1496891312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"217.504047ms","start":"2026-02-18T19:49:01.976536Z","end":"2026-02-18T19:49:02.19404Z","steps":["trace[1496891312] 'agreement among raft nodes before linearized reading' (duration: 217.469586ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:02.193908Z","caller":"traceutil/trace.go:171","msg":"trace[1844543331] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"615.876836ms","start":"2026-02-18T19:49:01.578023Z","end":"2026-02-18T19:49:02.193899Z","steps":["trace[1844543331] 'process raft request' (duration: 615.265453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.194155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:01.578007Z","time spent":"616.130411ms","remote":"127.0.0.1:55856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3798,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:02.194175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.429739ms","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-18T19:49:02.194201Z","caller":"traceutil/trace.go:171","msg":"trace[863213852] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"198.474229ms","start":"2026-02-18T19:49:01.99572Z","end":"2026-02-18T19:49:02.194194Z","steps":["trace[863213852] 'agreement among raft nodes before linearized reading' (duration: 198.381507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.194404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.478958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-18T19:49:02.194416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.062621ms","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-18T19:49:02.194424Z","caller":"traceutil/trace.go:171","msg":"trace[1604131808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"162.514389ms","start":"2026-02-18T19:49:02.031904Z","end":"2026-02-18T19:49:02.194418Z","steps":["trace[1604131808] 'agreement among raft nodes before linearized reading' (duration: 162.434577ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:02.194438Z","caller":"traceutil/trace.go:171","msg":"trace[1619241229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"163.092271ms","start":"2026-02-18T19:49:02.031338Z","end":"2026-02-18T19:49:02.194431Z","steps":["trace[1619241229] 'agreement among raft nodes before linearized reading' (duration: 163.015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:02.194519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.346294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-18T19:49:02.194576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.160265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:02.194536Z","caller":"traceutil/trace.go:171","msg":"trace[1507421548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"168.384995ms","start":"2026-02-18T19:49:02.026147Z","end":"2026-02-18T19:49:02.194532Z","steps":["trace[1507421548] 'agreement among raft nodes before linearized reading' (duration: 168.335864ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:02.194595Z","caller":"traceutil/trace.go:171","msg":"trace[299320896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"129.227657ms","start":"2026-02-18T19:49:02.065361Z","end":"2026-02-18T19:49:02.194589Z","steps":["trace[299320896] 'agreement among raft nodes before linearized reading' (duration: 129.167455ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:08.623886Z","caller":"traceutil/trace.go:171","msg":"trace[58864042] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:766; }","duration":"385.957213ms","start":"2026-02-18T19:49:08.237912Z","end":"2026-02-18T19:49:08.623869Z","steps":["trace[58864042] 'read index received' (duration: 385.80019ms)","trace[58864042] 'applied index is now lower than readState.Index' (duration: 156.443µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:49:08.624097Z","caller":"traceutil/trace.go:171","msg":"trace[1056451843] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"394.172989ms","start":"2026-02-18T19:49:08.229918Z","end":"2026-02-18T19:49:08.624091Z","steps":["trace[1056451843] 'process raft request' (duration: 393.866772ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.624164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.229901Z","time spent":"394.2114ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:08.624297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.385402ms","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-18T19:49:08.624314Z","caller":"traceutil/trace.go:171","msg":"trace[368212432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"386.429923ms","start":"2026-02-18T19:49:08.237878Z","end":"2026-02-18T19:49:08.624308Z","steps":["trace[368212432] 'agreement among raft nodes before linearized reading' (duration: 386.368542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.624328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.237862Z","time spent":"386.462664ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-18T19:49:08.624409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.968708ms","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-18T19:49:08.62442Z","caller":"traceutil/trace.go:171","msg":"trace[2146771068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:742; }","duration":"382.992719ms","start":"2026-02-18T19:49:08.241424Z","end":"2026-02-18T19:49:08.624416Z","steps":["trace[2146771068] 'agreement among raft nodes before linearized reading' (duration: 382.957218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.624431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.241417Z","time spent":"383.011539ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T19:49:08.62453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.025131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T19:49:08.624545Z","caller":"traceutil/trace.go:171","msg":"trace[1732694772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:742; }","duration":"377.049092ms","start":"2026-02-18T19:49:08.247492Z","end":"2026-02-18T19:49:08.624541Z","steps":["trace[1732694772] 'agreement among raft nodes before linearized reading' (duration: 377.011192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.624556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.247487Z","time spent":"377.065663ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T19:49:08.624624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.114529ms","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":"info","ts":"2026-02-18T19:49:08.624636Z","caller":"traceutil/trace.go:171","msg":"trace[662339930] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:742; }","duration":"381.126259ms","start":"2026-02-18T19:49:08.243506Z","end":"2026-02-18T19:49:08.624632Z","steps":["trace[662339930] 'agreement among raft nodes before linearized reading' (duration: 381.093629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.624647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.243486Z","time spent":"381.158511ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-18T19:49:08.936624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.731457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:49:08.936771Z","caller":"traceutil/trace.go:171","msg":"trace[2008171958] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"309.294893ms","start":"2026-02-18T19:49:08.627445Z","end":"2026-02-18T19:49:08.93674Z","steps":["trace[2008171958] 'process raft request' (duration: 95.28548ms)","trace[2008171958] 'compare' (duration: 212.840587ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:08.936818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.627434Z","time spent":"309.358524ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:08.937418Z","caller":"traceutil/trace.go:171","msg":"trace[1002934821] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:767; }","duration":"289.949697ms","start":"2026-02-18T19:49:08.647461Z","end":"2026-02-18T19:49:08.93741Z","steps":["trace[1002934821] 'read index received' (duration: 75.344372ms)","trace[1002934821] 'applied index is now lower than readState.Index' (duration: 214.604865ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:08.937479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.013558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:08.937748Z","caller":"traceutil/trace.go:171","msg":"trace[296630724] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"307.466213ms","start":"2026-02-18T19:49:08.630263Z","end":"2026-02-18T19:49:08.937729Z","steps":["trace[296630724] 'process raft request' (duration: 307.066594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.937855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.630256Z","time spent":"307.539395ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:08.937494Z","caller":"traceutil/trace.go:171","msg":"trace[1291946257] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:746; }","duration":"290.030508ms","start":"2026-02-18T19:49:08.647457Z","end":"2026-02-18T19:49:08.937487Z","steps":["trace[1291946257] 'agreement among raft nodes before linearized reading' (duration: 289.990548ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:08.938113Z","caller":"traceutil/trace.go:171","msg":"trace[219281131] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"305.790816ms","start":"2026-02-18T19:49:08.632316Z","end":"2026-02-18T19:49:08.938107Z","steps":["trace[219281131] 'process raft request' (duration: 305.079752ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.938148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.63231Z","time spent":"305.819437ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:08.938212Z","caller":"traceutil/trace.go:171","msg":"trace[73379269] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"307.135435ms","start":"2026-02-18T19:49:08.631072Z","end":"2026-02-18T19:49:08.938207Z","steps":["trace[73379269] 'process raft request' (duration: 306.305827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:08.93824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:08.631066Z","time spent":"307.158065ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:11.066816Z","caller":"traceutil/trace.go:171","msg":"trace[1537169366] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"123.110426ms","start":"2026-02-18T19:49:10.943687Z","end":"2026-02-18T19:49:11.066797Z","steps":["trace[1537169366] 'process raft request' (duration: 122.123205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:11.067064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.26975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T19:49:11.067098Z","caller":"traceutil/trace.go:171","msg":"trace[2044828713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"124.323281ms","start":"2026-02-18T19:49:10.942765Z","end":"2026-02-18T19:49:11.067088Z","steps":["trace[2044828713] 'agreement among raft nodes before linearized reading' (duration: 124.204699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:11.067608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.245563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:49:11.067648Z","caller":"traceutil/trace.go:171","msg":"trace[1483447000] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:752; }","duration":"112.292074ms","start":"2026-02-18T19:49:10.955346Z","end":"2026-02-18T19:49:11.067638Z","steps":["trace[1483447000] 'agreement among raft nodes before linearized reading' (duration: 112.222272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:11.816531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.001059ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-18T19:49:13.140868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895425,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:13.641589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895425,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:14.142677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895425,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:14.643669Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895425,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:14.952936Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.446471967s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T19:49:14.953138Z","caller":"traceutil/trace.go:171","msg":"trace[918504889] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"2.313174283s","start":"2026-02-18T19:49:12.639948Z","end":"2026-02-18T19:49:14.953123Z","steps":["trace[918504889] 'read index received' (duration: 2.313089711s)","trace[918504889] 'applied index is now lower than readState.Index' (duration: 83.602µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:14.953192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.506365Z","time spent":"2.446824084s","remote":"127.0.0.1:55740","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-18T19:49:14.953425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.31346639s","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-18T19:49:14.953455Z","caller":"traceutil/trace.go:171","msg":"trace[1830665595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"2.313535072s","start":"2026-02-18T19:49:12.639913Z","end":"2026-02-18T19:49:14.953448Z","steps":["trace[1830665595] 'agreement among raft nodes before linearized reading' (duration: 2.313426489s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.953474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.639899Z","time spent":"2.313570572s","remote":"127.0.0.1:55948","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-18T19:49:14.953594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.142891228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.953612Z","caller":"traceutil/trace.go:171","msg":"trace[1671047183] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:753; }","duration":"2.142911388s","start":"2026-02-18T19:49:12.810695Z","end":"2026-02-18T19:49:14.953606Z","steps":["trace[1671047183] 'agreement among raft nodes before linearized reading' (duration: 2.142877727s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.95363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.810655Z","time spent":"2.142970529s","remote":"127.0.0.1:57584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-02-18T19:49:14.953819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.823104171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.953838Z","caller":"traceutil/trace.go:171","msg":"trace[1180435406] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:753; }","duration":"1.823148463s","start":"2026-02-18T19:49:13.130685Z","end":"2026-02-18T19:49:14.953833Z","steps":["trace[1180435406] 'agreement among raft nodes before linearized reading' (duration: 1.823112422s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.953858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.130673Z","time spent":"1.823181413s","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:14.953974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.877007256s","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-18T19:49:14.95399Z","caller":"traceutil/trace.go:171","msg":"trace[1667414977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"1.877036986s","start":"2026-02-18T19:49:13.076948Z","end":"2026-02-18T19:49:14.953985Z","steps":["trace[1667414977] 'agreement among raft nodes before linearized reading' (duration: 1.876985845s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.07694Z","time spent":"1.877062926s","remote":"127.0.0.1:55948","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-18T19:49:14.954108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.882104464s","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-18T19:49:14.954124Z","caller":"traceutil/trace.go:171","msg":"trace[769547260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:753; }","duration":"1.882134225s","start":"2026-02-18T19:49:13.071985Z","end":"2026-02-18T19:49:14.95412Z","steps":["trace[769547260] 'agreement among raft nodes before linearized reading' (duration: 1.882088354s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.95414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.07198Z","time spent":"1.882156215s","remote":"127.0.0.1:55948","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-18T19:49:14.954234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.882444902s","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-18T19:49:14.95425Z","caller":"traceutil/trace.go:171","msg":"trace[374895325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"1.882477352s","start":"2026-02-18T19:49:13.071768Z","end":"2026-02-18T19:49:14.954245Z","steps":["trace[374895325] 'agreement among raft nodes before linearized reading' (duration: 1.882435061s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.07176Z","time spent":"1.882502193s","remote":"127.0.0.1:55948","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-18T19:49:14.95437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.890646688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.954387Z","caller":"traceutil/trace.go:171","msg":"trace[1385207361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"1.890680548s","start":"2026-02-18T19:49:13.063701Z","end":"2026-02-18T19:49:14.954382Z","steps":["trace[1385207361] 'agreement among raft nodes before linearized reading' (duration: 1.890631817s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.063691Z","time spent":"1.890714309s","remote":"127.0.0.1:55674","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-18T19:49:14.954525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.933562236s","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-18T19:49:14.954541Z","caller":"traceutil/trace.go:171","msg":"trace[278235952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:753; }","duration":"1.933603676s","start":"2026-02-18T19:49:13.020933Z","end":"2026-02-18T19:49:14.954536Z","steps":["trace[278235952] 'agreement among raft nodes before linearized reading' (duration: 1.933558416s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:13.02092Z","time spent":"1.933632787s","remote":"127.0.0.1:55948","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-18T19:49:14.954646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.098964247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.954664Z","caller":"traceutil/trace.go:171","msg":"trace[851444769] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:753; }","duration":"2.098988578s","start":"2026-02-18T19:49:12.85567Z","end":"2026-02-18T19:49:14.954659Z","steps":["trace[851444769] 'agreement among raft nodes before linearized reading' (duration: 2.098951317s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.855667Z","time spent":"2.099008978s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-18T19:49:14.954776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.09910657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.954795Z","caller":"traceutil/trace.go:171","msg":"trace[1517231979] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:753; }","duration":"2.099142161s","start":"2026-02-18T19:49:12.855648Z","end":"2026-02-18T19:49:14.95479Z","steps":["trace[1517231979] 'agreement among raft nodes before linearized reading' (duration: 2.09911358s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.855636Z","time spent":"2.099171371s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:14.954892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.099225043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.954909Z","caller":"traceutil/trace.go:171","msg":"trace[979700023] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:753; }","duration":"2.099255033s","start":"2026-02-18T19:49:12.855649Z","end":"2026-02-18T19:49:14.954904Z","steps":["trace[979700023] 'agreement among raft nodes before linearized reading' (duration: 2.099227023s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.954925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.855643Z","time spent":"2.099277534s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-02-18T19:49:14.955001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.114398058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.95502Z","caller":"traceutil/trace.go:171","msg":"trace[219132250] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:753; }","duration":"2.114422408s","start":"2026-02-18T19:49:12.840591Z","end":"2026-02-18T19:49:14.955014Z","steps":["trace[219132250] 'agreement among raft nodes before linearized reading' (duration: 2.114396778s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.955037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.840577Z","time spent":"2.114455609s","remote":"127.0.0.1:57588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:14.95513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.114554051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.95515Z","caller":"traceutil/trace.go:171","msg":"trace[1461842660] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:753; }","duration":"2.114578961s","start":"2026-02-18T19:49:12.840563Z","end":"2026-02-18T19:49:14.955141Z","steps":["trace[1461842660] 'agreement among raft nodes before linearized reading' (duration: 2.114552871s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.955186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.840559Z","time spent":"2.114621622s","remote":"127.0.0.1:57588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-02-18T19:49:14.955264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.11495194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.955281Z","caller":"traceutil/trace.go:171","msg":"trace[460122101] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:753; }","duration":"2.11496914s","start":"2026-02-18T19:49:12.840307Z","end":"2026-02-18T19:49:14.955276Z","steps":["trace[460122101] 'agreement among raft nodes before linearized reading' (duration: 2.114944249s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.955298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.840287Z","time spent":"2.11500581s","remote":"127.0.0.1:57588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-02-18T19:49:14.955389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.12945582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.955405Z","caller":"traceutil/trace.go:171","msg":"trace[1135094216] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:753; }","duration":"2.129487431s","start":"2026-02-18T19:49:12.825913Z","end":"2026-02-18T19:49:14.955401Z","steps":["trace[1135094216] 'agreement among raft nodes before linearized reading' (duration: 2.12946152s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.955422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.825906Z","time spent":"2.129511381s","remote":"127.0.0.1:57584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-02-18T19:49:14.955501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.144115284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:14.955518Z","caller":"traceutil/trace.go:171","msg":"trace[553694144] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:753; }","duration":"2.144144534s","start":"2026-02-18T19:49:12.811368Z","end":"2026-02-18T19:49:14.955513Z","steps":["trace[553694144] 'agreement among raft nodes before linearized reading' (duration: 2.144118483s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:14.955534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:12.811362Z","time spent":"2.144167324s","remote":"127.0.0.1:57584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:15.407099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.4968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:49:15.407208Z","caller":"traceutil/trace.go:171","msg":"trace[1632972157] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"446.750145ms","start":"2026-02-18T19:49:14.96043Z","end":"2026-02-18T19:49:15.40718Z","steps":["trace[1632972157] 'process raft request' (duration: 311.0857ms)","trace[1632972157] 'compare' (duration: 135.389178ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:15.407257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.960422Z","time spent":"446.816236ms","remote":"127.0.0.1:55948","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-18T19:49:15.753944Z","caller":"traceutil/trace.go:171","msg":"trace[882416022] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:780; }","duration":"780.090419ms","start":"2026-02-18T19:49:14.97383Z","end":"2026-02-18T19:49:15.75392Z","steps":["trace[882416022] 'read index received' (duration: 297.754043ms)","trace[882416022] 'applied index is now lower than readState.Index' (duration: 482.335736ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:49:15.754022Z","caller":"traceutil/trace.go:171","msg":"trace[56146052] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"790.677096ms","start":"2026-02-18T19:49:14.963338Z","end":"2026-02-18T19:49:15.754015Z","steps":["trace[56146052] 'process raft request' (duration: 768.648744ms)","trace[56146052] 'compare' (duration: 21.513451ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:15.754076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.963332Z","time spent":"790.706227ms","remote":"127.0.0.1:55740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T19:49:15.754269Z","caller":"traceutil/trace.go:171","msg":"trace[900122375] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"787.067379ms","start":"2026-02-18T19:49:14.967195Z","end":"2026-02-18T19:49:15.754263Z","steps":["trace[900122375] 'process raft request' (duration: 786.6251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.754309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.967189Z","time spent":"787.09514ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:15.75438Z","caller":"traceutil/trace.go:171","msg":"trace[904255452] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"783.107254ms","start":"2026-02-18T19:49:14.971268Z","end":"2026-02-18T19:49:15.754375Z","steps":["trace[904255452] 'process raft request' (duration: 782.593603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.754409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.971262Z","time spent":"783.131624ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:15.754474Z","caller":"traceutil/trace.go:171","msg":"trace[1289078482] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"783.165037ms","start":"2026-02-18T19:49:14.971304Z","end":"2026-02-18T19:49:15.754469Z","steps":["trace[1289078482] 'process raft request' (duration: 782.576323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.754503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.971301Z","time spent":"783.186017ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:15.754564Z","caller":"traceutil/trace.go:171","msg":"trace[1946584166] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"783.234358ms","start":"2026-02-18T19:49:14.971325Z","end":"2026-02-18T19:49:15.754559Z","steps":["trace[1946584166] 'process raft request' (duration: 782.573213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.754593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.971322Z","time spent":"783.255708ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:15.754665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.832866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:15.754683Z","caller":"traceutil/trace.go:171","msg":"trace[1121533603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:759; }","duration":"780.860937ms","start":"2026-02-18T19:49:14.973817Z","end":"2026-02-18T19:49:15.754678Z","steps":["trace[1121533603] 'agreement among raft nodes before linearized reading' (duration: 780.831356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.7547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:14.973811Z","time spent":"780.885438ms","remote":"127.0.0.1:55674","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-18T19:49:15.754778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.885603ms","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-18T19:49:15.754796Z","caller":"traceutil/trace.go:171","msg":"trace[990095838] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:759; }","duration":"507.925534ms","start":"2026-02-18T19:49:15.246864Z","end":"2026-02-18T19:49:15.75479Z","steps":["trace[990095838] 'agreement among raft nodes before linearized reading' (duration: 507.898104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:15.754812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:15.246839Z","time spent":"507.968565ms","remote":"127.0.0.1:55842","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-18T19:49:16.690723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.164687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:49:16.690927Z","caller":"traceutil/trace.go:171","msg":"trace[1083356148] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"130.151028ms","start":"2026-02-18T19:49:16.560758Z","end":"2026-02-18T19:49:16.690909Z","steps":["trace[1083356148] 'process raft request' (duration: 130.074086ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:16.690972Z","caller":"traceutil/trace.go:171","msg":"trace[1390218770] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"265.551286ms","start":"2026-02-18T19:49:16.42537Z","end":"2026-02-18T19:49:16.690921Z","steps":["trace[1390218770] 'read index received' (duration: 20.96µs)","trace[1390218770] 'applied index is now lower than readState.Index' (duration: 265.528416ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:16.691111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.715059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:16.69114Z","caller":"traceutil/trace.go:171","msg":"trace[289933988] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:761; }","duration":"265.790931ms","start":"2026-02-18T19:49:16.425341Z","end":"2026-02-18T19:49:16.691132Z","steps":["trace[289933988] 'agreement among raft nodes before linearized reading' (duration: 265.686249ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:16.691342Z","caller":"traceutil/trace.go:171","msg":"trace[1514310865] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"449.211806ms","start":"2026-02-18T19:49:16.242118Z","end":"2026-02-18T19:49:16.691329Z","steps":["trace[1514310865] 'process raft request' (duration: 162.326914ms)","trace[1514310865] 'compare' (duration: 285.856171ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:16.691422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:16.242107Z","time spent":"449.259737ms","remote":"127.0.0.1:55688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:18.564756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895458,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:19.065691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895458,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:19.312876Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.542725106s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T19:49:19.313124Z","caller":"traceutil/trace.go:171","msg":"trace[388513675] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"1.543055233s","start":"2026-02-18T19:49:17.770054Z","end":"2026-02-18T19:49:19.313109Z","steps":["trace[388513675] 'process raft request' (duration: 1.542978571s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:19.313205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:17.770043Z","time spent":"1.543108795s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:19.388008Z","caller":"traceutil/trace.go:171","msg":"trace[733646530] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:791; }","duration":"1.32336878s","start":"2026-02-18T19:49:18.06462Z","end":"2026-02-18T19:49:19.387989Z","steps":["trace[733646530] 'read index received' (duration: 1.248841354s)","trace[733646530] 'applied index is now lower than readState.Index' (duration: 74.526696ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:19.388133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323497082s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:19.388167Z","caller":"traceutil/trace.go:171","msg":"trace[1408369313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"1.323570844s","start":"2026-02-18T19:49:18.064587Z","end":"2026-02-18T19:49:19.388158Z","steps":["trace[1408369313] 'agreement among raft nodes before linearized reading' (duration: 1.323477582s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:19.388201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:18.064574Z","time spent":"1.323620205s","remote":"127.0.0.1:55660","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-18T19:49:19.388459Z","caller":"traceutil/trace.go:171","msg":"trace[1712413390] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"1.615988344s","start":"2026-02-18T19:49:17.772458Z","end":"2026-02-18T19:49:19.388446Z","steps":["trace[1712413390] 'process raft request' (duration: 1.615444003s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:19.388539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:17.772452Z","time spent":"1.616039085s","remote":"127.0.0.1:55948","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-18T19:49:19.388862Z","caller":"traceutil/trace.go:171","msg":"trace[1065863025] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"1.609308441s","start":"2026-02-18T19:49:17.779467Z","end":"2026-02-18T19:49:19.388775Z","steps":["trace[1065863025] 'process raft request' (duration: 1.608474274s)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:19.388688Z","caller":"traceutil/trace.go:171","msg":"trace[1983432168] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"1.618403006s","start":"2026-02-18T19:49:17.770274Z","end":"2026-02-18T19:49:19.388677Z","steps":["trace[1983432168] 'process raft request' (duration: 1.617540688s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:19.38898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:17.77945Z","time spent":"1.609496056s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:19.389238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:17.770269Z","time spent":"1.618767054s","remote":"127.0.0.1:55948","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-18T19:49:19.580949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.15972ms","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-18T19:49:19.581009Z","caller":"traceutil/trace.go:171","msg":"trace[1073824957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:766; }","duration":"147.248741ms","start":"2026-02-18T19:49:19.433747Z","end":"2026-02-18T19:49:19.580996Z","steps":["trace[1073824957] 'range keys from in-memory index tree' (duration: 147.039637ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:19.684445Z","caller":"traceutil/trace.go:171","msg":"trace[85594188] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"100.292776ms","start":"2026-02-18T19:49:19.584137Z","end":"2026-02-18T19:49:19.68443Z","steps":["trace[85594188] 'process raft request' (duration: 100.166283ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:29.727947Z","caller":"traceutil/trace.go:171","msg":"trace[512279646] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"254.883746ms","start":"2026-02-18T19:49:29.473037Z","end":"2026-02-18T19:49:29.727921Z","steps":["trace[512279646] 'read index received' (duration: 250.590094ms)","trace[512279646] 'applied index is now lower than readState.Index' (duration: 4.292262ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:29.728421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.338236ms","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-18T19:49:29.728519Z","caller":"traceutil/trace.go:171","msg":"trace[1947804598] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"255.499419ms","start":"2026-02-18T19:49:29.473007Z","end":"2026-02-18T19:49:29.728506Z","steps":["trace[1947804598] 'agreement among raft nodes before linearized reading' (duration: 255.267964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:29.728717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.633632ms","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-18T19:49:29.728786Z","caller":"traceutil/trace.go:171","msg":"trace[639420754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"255.715954ms","start":"2026-02-18T19:49:29.473066Z","end":"2026-02-18T19:49:29.728781Z","steps":["trace[639420754] 'agreement among raft nodes before linearized reading' (duration: 255.617992ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:29.728014Z","caller":"traceutil/trace.go:171","msg":"trace[1080868222] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"275.934727ms","start":"2026-02-18T19:49:29.452061Z","end":"2026-02-18T19:49:29.727996Z","steps":["trace[1080868222] 'process raft request' (duration: 271.613094ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:32.190099Z","caller":"traceutil/trace.go:171","msg":"trace[224979318] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"777.645297ms","start":"2026-02-18T19:49:31.412424Z","end":"2026-02-18T19:49:32.190069Z","steps":["trace[224979318] 'process raft request' (duration: 777.464192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.190309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.4124Z","time spent":"777.80426ms","remote":"127.0.0.1:55948","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-18T19:49:32.569638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.042473ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-18T19:49:32.570221Z","caller":"traceutil/trace.go:171","msg":"trace[1176392897] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"837.295821ms","start":"2026-02-18T19:49:31.732904Z","end":"2026-02-18T19:49:32.5702Z","steps":["trace[1176392897] 'read index received' (duration: 465.564925ms)","trace[1176392897] 'applied index is now lower than readState.Index' (duration: 371.729176ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:32.5705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.569547ms","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-18T19:49:32.570578Z","caller":"traceutil/trace.go:171","msg":"trace[1883170633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"837.69441ms","start":"2026-02-18T19:49:31.732866Z","end":"2026-02-18T19:49:32.57056Z","steps":["trace[1883170633] 'agreement among raft nodes before linearized reading' (duration: 837.463685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.570633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.73285Z","time spent":"837.773541ms","remote":"127.0.0.1:55948","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-18T19:49:32.570893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.94691ms","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-18T19:49:32.57099Z","caller":"traceutil/trace.go:171","msg":"trace[737595519] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"784.206274ms","start":"2026-02-18T19:49:31.786771Z","end":"2026-02-18T19:49:32.570977Z","steps":["trace[737595519] 'agreement among raft nodes before linearized reading' (duration: 783.675283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.571137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.554974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:32.571187Z","caller":"traceutil/trace.go:171","msg":"trace[1545289327] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:802; }","duration":"720.636277ms","start":"2026-02-18T19:49:31.85054Z","end":"2026-02-18T19:49:32.571176Z","steps":["trace[1545289327] 'agreement among raft nodes before linearized reading' (duration: 720.572095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.571218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.850527Z","time spent":"720.682137ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:32.571276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.786748Z","time spent":"784.41603ms","remote":"127.0.0.1:55948","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-18T19:49:32.571524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.148602ms","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-18T19:49:32.571577Z","caller":"traceutil/trace.go:171","msg":"trace[1509011604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"739.201743ms","start":"2026-02-18T19:49:31.832366Z","end":"2026-02-18T19:49:32.571568Z","steps":["trace[1509011604] 'agreement among raft nodes before linearized reading' (duration: 739.095631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.571605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.832339Z","time spent":"739.259554ms","remote":"127.0.0.1:55948","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-18T19:49:32.571055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.70696ms","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-18T19:49:32.572308Z","caller":"traceutil/trace.go:171","msg":"trace[423061149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"708.992756ms","start":"2026-02-18T19:49:31.863306Z","end":"2026-02-18T19:49:32.572298Z","steps":["trace[423061149] 'agreement among raft nodes before linearized reading' (duration: 707.662507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:32.572344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:31.863289Z","time spent":"709.045248ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-18T19:49:32.816441Z","caller":"traceutil/trace.go:171","msg":"trace[843372345] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"237.758891ms","start":"2026-02-18T19:49:32.578659Z","end":"2026-02-18T19:49:32.816418Z","steps":["trace[843372345] 'process raft request' (duration: 237.415443ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:32.818203Z","caller":"traceutil/trace.go:171","msg":"trace[159684815] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"237.387033ms","start":"2026-02-18T19:49:32.580801Z","end":"2026-02-18T19:49:32.818188Z","steps":["trace[159684815] 'process raft request' (duration: 237.354272ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:32.81928Z","caller":"traceutil/trace.go:171","msg":"trace[1588902520] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"240.401888ms","start":"2026-02-18T19:49:32.578863Z","end":"2026-02-18T19:49:32.819265Z","steps":["trace[1588902520] 'process raft request' (duration: 239.186492ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:32.819331Z","caller":"traceutil/trace.go:171","msg":"trace[1981920024] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"239.573619ms","start":"2026-02-18T19:49:32.579744Z","end":"2026-02-18T19:49:32.819318Z","steps":["trace[1981920024] 'process raft request' (duration: 238.377174ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:42.664952Z","caller":"traceutil/trace.go:171","msg":"trace[1597767432] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"102.690988ms","start":"2026-02-18T19:49:42.562238Z","end":"2026-02-18T19:49:42.664929Z","steps":["trace[1597767432] 'process raft request' (duration: 76.416255ms)","trace[1597767432] 'compare' (duration: 25.630889ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:49:46.672401Z","caller":"traceutil/trace.go:171","msg":"trace[421693933] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"282.063757ms","start":"2026-02-18T19:49:46.390315Z","end":"2026-02-18T19:49:46.672379Z","steps":["trace[421693933] 'read index received' (duration: 281.905694ms)","trace[421693933] 'applied index is now lower than readState.Index' (duration: 156.773µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:46.672464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.212841Z","time spent":"459.61656ms","remote":"127.0.0.1:55688","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-18T19:49:46.672592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.257742ms","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-18T19:49:46.672636Z","caller":"traceutil/trace.go:171","msg":"trace[515260164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:893; }","duration":"282.339884ms","start":"2026-02-18T19:49:46.390287Z","end":"2026-02-18T19:49:46.672627Z","steps":["trace[515260164] 'agreement among raft nodes before linearized reading' (duration: 282.18086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:47.384602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895761,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:47.785267Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.002631514s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T19:49:47.789053Z","caller":"traceutil/trace.go:171","msg":"trace[1397792293] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"1.114161963s","start":"2026-02-18T19:49:46.67487Z","end":"2026-02-18T19:49:47.789032Z","steps":["trace[1397792293] 'process raft request' (duration: 1.113997429s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:47.789182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.674849Z","time spent":"1.114265206s","remote":"127.0.0.1:55688","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-18T19:49:48.018493Z","caller":"traceutil/trace.go:171","msg":"trace[1295266841] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"1.3400713s","start":"2026-02-18T19:49:46.678407Z","end":"2026-02-18T19:49:48.018478Z","steps":["trace[1295266841] 'process raft request' (duration: 1.339963848s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.018576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.678383Z","time spent":"1.340151161s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:48.018664Z","caller":"traceutil/trace.go:171","msg":"trace[1781084506] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:928; }","duration":"1.13459286s","start":"2026-02-18T19:49:46.884057Z","end":"2026-02-18T19:49:48.01865Z","steps":["trace[1781084506] 'read index received' (duration: 904.750339ms)","trace[1781084506] 'applied index is now lower than readState.Index' (duration: 229.841671ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:48.018792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134733693s","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-18T19:49:48.018808Z","caller":"traceutil/trace.go:171","msg":"trace[1779383329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:896; }","duration":"1.134784864s","start":"2026-02-18T19:49:46.884018Z","end":"2026-02-18T19:49:48.018803Z","steps":["trace[1779383329] 'agreement among raft nodes before linearized reading' (duration: 1.134723033s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.018822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.883998Z","time spent":"1.134821565s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-18T19:49:48.018881Z","caller":"traceutil/trace.go:171","msg":"trace[1923034256] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"815.04712ms","start":"2026-02-18T19:49:47.203829Z","end":"2026-02-18T19:49:48.018877Z","steps":["trace[1923034256] 'process raft request' (duration: 814.628771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.018892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071120592s","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-18T19:49:48.018907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:47.203809Z","time spent":"815.08159ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:48.018921Z","caller":"traceutil/trace.go:171","msg":"trace[630043310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:896; }","duration":"1.071179142s","start":"2026-02-18T19:49:46.947733Z","end":"2026-02-18T19:49:48.018912Z","steps":["trace[630043310] 'agreement among raft nodes before linearized reading' (duration: 1.07108859s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.018955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.947718Z","time spent":"1.071229194s","remote":"127.0.0.1:55948","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-18T19:49:48.019046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.482502ms","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-18T19:49:48.019069Z","caller":"traceutil/trace.go:171","msg":"trace[209371567] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:896; }","duration":"228.535474ms","start":"2026-02-18T19:49:47.790526Z","end":"2026-02-18T19:49:48.019062Z","steps":["trace[209371567] 'agreement among raft nodes before linearized reading' (duration: 228.493873ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.019155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043010979s","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-18T19:49:48.01917Z","caller":"traceutil/trace.go:171","msg":"trace[152011455] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:896; }","duration":"1.043055961s","start":"2026-02-18T19:49:46.976109Z","end":"2026-02-18T19:49:48.019165Z","steps":["trace[152011455] 'agreement among raft nodes before linearized reading' (duration: 1.0430076s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.019182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.976098Z","time spent":"1.043081681s","remote":"127.0.0.1:55948","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-18T19:49:48.019224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071419838s","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-18T19:49:48.019244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.453335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:48.019256Z","caller":"traceutil/trace.go:171","msg":"trace[1361984049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:896; }","duration":"955.488457ms","start":"2026-02-18T19:49:47.063764Z","end":"2026-02-18T19:49:48.019252Z","steps":["trace[1361984049] 'agreement among raft nodes before linearized reading' (duration: 955.469246ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:48.019249Z","caller":"traceutil/trace.go:171","msg":"trace[1064869747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:896; }","duration":"1.071453328s","start":"2026-02-18T19:49:46.947788Z","end":"2026-02-18T19:49:48.019241Z","steps":["trace[1064869747] 'agreement among raft nodes before linearized reading' (duration: 1.071384117s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:48.019266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:47.063751Z","time spent":"955.512907ms","remote":"127.0.0.1:55674","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-18T19:49:48.019275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:46.947785Z","time spent":"1.071484609s","remote":"127.0.0.1:55948","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-18T19:49:50.550768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895783,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:51.051867Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895783,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T19:49:51.536418Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.505159067s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T19:49:51.536727Z","caller":"traceutil/trace.go:171","msg":"trace[841639790] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"1.505500894s","start":"2026-02-18T19:49:50.0312Z","end":"2026-02-18T19:49:51.536701Z","steps":["trace[841639790] 'process raft request' (duration: 1.505379832s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.536843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.031191Z","time spent":"1.505592606s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:51.536844Z","caller":"traceutil/trace.go:171","msg":"trace[214651040] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:936; }","duration":"1.486667891s","start":"2026-02-18T19:49:50.050128Z","end":"2026-02-18T19:49:51.536796Z","steps":["trace[214651040] 'read index received' (duration: 1.486656891s)","trace[214651040] 'applied index is now lower than readState.Index' (duration: 6.84µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:51.537161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.486986978s","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-18T19:49:51.537198Z","caller":"traceutil/trace.go:171","msg":"trace[1268039992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:901; }","duration":"1.487080969s","start":"2026-02-18T19:49:50.050106Z","end":"2026-02-18T19:49:51.537187Z","steps":["trace[1268039992] 'agreement among raft nodes before linearized reading' (duration: 1.486817074s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.537267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.050097Z","time spent":"1.487152531s","remote":"127.0.0.1:55948","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-18T19:49:51.792409Z","caller":"traceutil/trace.go:171","msg":"trace[342996686] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:936; }","duration":"255.51554ms","start":"2026-02-18T19:49:51.53688Z","end":"2026-02-18T19:49:51.792396Z","steps":["trace[342996686] 'read index received' (duration: 228.170254ms)","trace[342996686] 'applied index is now lower than readState.Index' (duration: 27.344846ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:51.79253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.742351294s","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-18T19:49:51.792546Z","caller":"traceutil/trace.go:171","msg":"trace[468613057] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:902; }","duration":"1.742387115s","start":"2026-02-18T19:49:50.050154Z","end":"2026-02-18T19:49:51.792541Z","steps":["trace[468613057] 'agreement among raft nodes before linearized reading' (duration: 1.742292113s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.792562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.05015Z","time spent":"1.742408095s","remote":"127.0.0.1:55948","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":"info","ts":"2026-02-18T19:49:51.792684Z","caller":"traceutil/trace.go:171","msg":"trace[633796349] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"733.763791ms","start":"2026-02-18T19:49:51.058915Z","end":"2026-02-18T19:49:51.792678Z","steps":["trace[633796349] 'process raft request' (duration: 706.129119ms)","trace[633796349] 'compare' (duration: 27.303355ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:51.792725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:51.058872Z","time spent":"733.823912ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:51.792792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.034937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:49:51.792806Z","caller":"traceutil/trace.go:171","msg":"trace[1187395066] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:902; }","duration":"607.085248ms","start":"2026-02-18T19:49:51.185715Z","end":"2026-02-18T19:49:51.792801Z","steps":["trace[1187395066] 'agreement among raft nodes before linearized reading' (duration: 607.057458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.792818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:51.185697Z","time spent":"607.117879ms","remote":"127.0.0.1:56018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:49:51.792893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.729382556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:51.792907Z","caller":"traceutil/trace.go:171","msg":"trace[674916890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:902; }","duration":"1.729423897s","start":"2026-02-18T19:49:50.063479Z","end":"2026-02-18T19:49:51.792903Z","steps":["trace[674916890] 'agreement among raft nodes before linearized reading' (duration: 1.729403396s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.792918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.063466Z","time spent":"1.729449048s","remote":"127.0.0.1:55674","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-18T19:49:51.792996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.741224529s","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-18T19:49:51.793007Z","caller":"traceutil/trace.go:171","msg":"trace[901591813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:902; }","duration":"1.74124719s","start":"2026-02-18T19:49:50.051756Z","end":"2026-02-18T19:49:51.793003Z","steps":["trace[901591813] 'agreement among raft nodes before linearized reading' (duration: 1.741213119s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.793017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.05175Z","time spent":"1.74126482s","remote":"127.0.0.1:55948","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-18T19:49:51.793085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.742554758s","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-18T19:49:51.793098Z","caller":"traceutil/trace.go:171","msg":"trace[1913074650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:902; }","duration":"1.742575019s","start":"2026-02-18T19:49:50.050517Z","end":"2026-02-18T19:49:51.793092Z","steps":["trace[1913074650] 'agreement among raft nodes before linearized reading' (duration: 1.742542168s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:51.793109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:50.050512Z","time spent":"1.74259407s","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-18T19:49:51.793511Z","caller":"traceutil/trace.go:171","msg":"trace[874280553] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"252.845133ms","start":"2026-02-18T19:49:51.540659Z","end":"2026-02-18T19:49:51.793504Z","steps":["trace[874280553] 'process raft request' (duration: 252.721031ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:55.70151Z","caller":"traceutil/trace.go:171","msg":"trace[1920415240] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"153.997427ms","start":"2026-02-18T19:49:55.547497Z","end":"2026-02-18T19:49:55.701495Z","steps":["trace[1920415240] 'process raft request' (duration: 153.928356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.309854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810446886895834,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T19:49:58.652423Z","caller":"traceutil/trace.go:171","msg":"trace[9513485] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"934.56789ms","start":"2026-02-18T19:49:57.717839Z","end":"2026-02-18T19:49:58.652407Z","steps":["trace[9513485] 'process raft request' (duration: 934.364865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.652515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:57.717817Z","time spent":"934.650161ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:58.726178Z","caller":"traceutil/trace.go:171","msg":"trace[431283689] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"916.824068ms","start":"2026-02-18T19:49:57.809337Z","end":"2026-02-18T19:49:58.726161Z","steps":["trace[431283689] 'read index received' (duration: 843.053719ms)","trace[431283689] 'applied index is now lower than readState.Index' (duration: 73.769709ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:49:58.726704Z","caller":"traceutil/trace.go:171","msg":"trace[1431275539] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"588.425158ms","start":"2026-02-18T19:49:58.138271Z","end":"2026-02-18T19:49:58.726696Z","steps":["trace[1431275539] 'process raft request' (duration: 585.700429ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.726828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.138254Z","time spent":"588.508749ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:49:58.7271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.765718ms","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-18T19:49:58.727156Z","caller":"traceutil/trace.go:171","msg":"trace[452617994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:919; }","duration":"917.823029ms","start":"2026-02-18T19:49:57.809327Z","end":"2026-02-18T19:49:58.72715Z","steps":["trace[452617994] 'agreement among raft nodes before linearized reading' (duration: 917.696616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.727915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:57.80929Z","time spent":"918.617527ms","remote":"127.0.0.1:55948","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-18T19:49:58.728151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.148915ms","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-18T19:49:58.728223Z","caller":"traceutil/trace.go:171","msg":"trace[1755202302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:919; }","duration":"895.262277ms","start":"2026-02-18T19:49:57.832943Z","end":"2026-02-18T19:49:58.728205Z","steps":["trace[1755202302] 'agreement among raft nodes before linearized reading' (duration: 895.018112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.72827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:57.832928Z","time spent":"895.333359ms","remote":"127.0.0.1:55948","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-18T19:49:58.72844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.941634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:58.728477Z","caller":"traceutil/trace.go:171","msg":"trace[374096050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:919; }","duration":"663.976305ms","start":"2026-02-18T19:49:58.064491Z","end":"2026-02-18T19:49:58.728467Z","steps":["trace[374096050] 'agreement among raft nodes before linearized reading' (duration: 663.921074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.728539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.064433Z","time spent":"664.100457ms","remote":"127.0.0.1:55674","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-18T19:49:58.72882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.936359ms","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-18T19:49:58.728885Z","caller":"traceutil/trace.go:171","msg":"trace[1607315022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:919; }","duration":"866.020691ms","start":"2026-02-18T19:49:57.862856Z","end":"2026-02-18T19:49:58.728876Z","steps":["trace[1607315022] 'agreement among raft nodes before linearized reading' (duration: 865.875397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.728922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:57.862846Z","time spent":"866.068651ms","remote":"127.0.0.1:55948","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-18T19:49:58.729558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.633291ms","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-18T19:49:58.72964Z","caller":"traceutil/trace.go:171","msg":"trace[646468141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:919; }","duration":"871.734833ms","start":"2026-02-18T19:49:57.857894Z","end":"2026-02-18T19:49:58.729629Z","steps":["trace[646468141] 'agreement among raft nodes before linearized reading' (duration: 871.543549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:58.730486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:57.857884Z","time spent":"872.592102ms","remote":"127.0.0.1:55948","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-18T19:49:59.050219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.344473ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:59.050338Z","caller":"traceutil/trace.go:171","msg":"trace[29523973] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:919; }","duration":"124.464195ms","start":"2026-02-18T19:49:58.925847Z","end":"2026-02-18T19:49:59.050311Z","steps":["trace[29523973] 'range keys from in-memory index tree' (duration: 124.332033ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:49:59.050401Z","caller":"traceutil/trace.go:171","msg":"trace[1416319006] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"316.581638ms","start":"2026-02-18T19:49:58.733798Z","end":"2026-02-18T19:49:59.05038Z","steps":["trace[1416319006] 'read index received' (duration: 314.253968ms)","trace[1416319006] 'applied index is now lower than readState.Index' (duration: 2.32709ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:49:59.050507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.69567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:49:59.050523Z","caller":"traceutil/trace.go:171","msg":"trace[1930832893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:920; }","duration":"316.723371ms","start":"2026-02-18T19:49:58.733795Z","end":"2026-02-18T19:49:59.050519Z","steps":["trace[1930832893] 'agreement among raft nodes before linearized reading' (duration: 316.647249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:59.050539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.733773Z","time spent":"316.762972ms","remote":"127.0.0.1:55660","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-18T19:49:59.050589Z","caller":"traceutil/trace.go:171","msg":"trace[1262139711] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"318.784115ms","start":"2026-02-18T19:49:58.731796Z","end":"2026-02-18T19:49:59.05058Z","steps":["trace[1262139711] 'process raft request' (duration: 316.24016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:59.050652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.731761Z","time spent":"318.848717ms","remote":"127.0.0.1:55948","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-18T19:49:59.052704Z","caller":"traceutil/trace.go:171","msg":"trace[1261334057] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"316.405955ms","start":"2026-02-18T19:49:58.736289Z","end":"2026-02-18T19:49:59.052695Z","steps":["trace[1261334057] 'process raft request' (duration: 316.381864ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:59.052762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.736282Z","time spent":"316.452295ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:49:59.052886Z","caller":"traceutil/trace.go:171","msg":"trace[804099529] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"318.478438ms","start":"2026-02-18T19:49:58.734399Z","end":"2026-02-18T19:49:59.052878Z","steps":["trace[804099529] 'process raft request' (duration: 318.164742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:59.052924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.73439Z","time spent":"318.51643ms","remote":"127.0.0.1:55948","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-18T19:49:59.052974Z","caller":"traceutil/trace.go:171","msg":"trace[2126662654] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"317.561139ms","start":"2026-02-18T19:49:58.735408Z","end":"2026-02-18T19:49:59.052969Z","steps":["trace[2126662654] 'process raft request' (duration: 317.218392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:49:59.053005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:49:58.7354Z","time spent":"317.59062ms","remote":"127.0.0.1:55948","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-18T19:50:05.263195Z","caller":"traceutil/trace.go:171","msg":"trace[718098477] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"197.549547ms","start":"2026-02-18T19:50:05.065624Z","end":"2026-02-18T19:50:05.263173Z","steps":["trace[718098477] 'read index received' (duration: 197.369052ms)","trace[718098477] 'applied index is now lower than readState.Index' (duration: 179.655µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:05.263333Z","caller":"traceutil/trace.go:171","msg":"trace[1867279008] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"578.631193ms","start":"2026-02-18T19:50:04.684692Z","end":"2026-02-18T19:50:05.263323Z","steps":["trace[1867279008] 'process raft request' (duration: 578.337557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.263423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:04.684682Z","time spent":"578.676664ms","remote":"127.0.0.1:55948","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-18T19:50:05.263581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.863916ms","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-18T19:50:05.263628Z","caller":"traceutil/trace.go:171","msg":"trace[1496252930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:935; }","duration":"191.943429ms","start":"2026-02-18T19:50:05.071672Z","end":"2026-02-18T19:50:05.263616Z","steps":["trace[1496252930] 'agreement among raft nodes before linearized reading' (duration: 191.817556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.263706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.082888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:05.263717Z","caller":"traceutil/trace.go:171","msg":"trace[1973052133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:935; }","duration":"198.12076ms","start":"2026-02-18T19:50:05.065592Z","end":"2026-02-18T19:50:05.263713Z","steps":["trace[1973052133] 'agreement among raft nodes before linearized reading' (duration: 198.102799ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.263827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.468645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-18T19:50:05.263841Z","caller":"traceutil/trace.go:171","msg":"trace[1183322090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:935; }","duration":"172.491685ms","start":"2026-02-18T19:50:05.091343Z","end":"2026-02-18T19:50:05.263835Z","steps":["trace[1183322090] 'agreement among raft nodes before linearized reading' (duration: 172.452264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.263907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.530527ms","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":"info","ts":"2026-02-18T19:50:05.263919Z","caller":"traceutil/trace.go:171","msg":"trace[999527883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:935; }","duration":"173.597708ms","start":"2026-02-18T19:50:05.090316Z","end":"2026-02-18T19:50:05.263914Z","steps":["trace[999527883] 'agreement among raft nodes before linearized reading' (duration: 173.555197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.26397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.099452ms","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-18T19:50:05.263979Z","caller":"traceutil/trace.go:171","msg":"trace[519041034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:935; }","duration":"192.141363ms","start":"2026-02-18T19:50:05.071835Z","end":"2026-02-18T19:50:05.263976Z","steps":["trace[519041034] 'agreement among raft nodes before linearized reading' (duration: 192.110532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.59414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.515217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:05.594275Z","caller":"traceutil/trace.go:171","msg":"trace[763242801] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"322.796798ms","start":"2026-02-18T19:50:05.271469Z","end":"2026-02-18T19:50:05.594265Z","steps":["trace[763242801] 'process raft request' (duration: 322.778127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.594307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:05.271463Z","time spent":"322.829959ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:05.594449Z","caller":"traceutil/trace.go:171","msg":"trace[1178640918] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"325.230489ms","start":"2026-02-18T19:50:05.269213Z","end":"2026-02-18T19:50:05.594444Z","steps":["trace[1178640918] 'process raft request' (duration: 23.355145ms)","trace[1178640918] 'compare' (duration: 301.367154ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:05.594472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:05.269204Z","time spent":"325.255991ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:05.594527Z","caller":"traceutil/trace.go:171","msg":"trace[1463834030] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"325.181069ms","start":"2026-02-18T19:50:05.26934Z","end":"2026-02-18T19:50:05.594521Z","steps":["trace[1463834030] 'process raft request' (duration: 324.869132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.594547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:05.269335Z","time spent":"325.200989ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:05.594596Z","caller":"traceutil/trace.go:171","msg":"trace[675995969] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"325.228779ms","start":"2026-02-18T19:50:05.269363Z","end":"2026-02-18T19:50:05.594592Z","steps":["trace[675995969] 'process raft request' (duration: 324.869192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:05.594617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:05.26936Z","time spent":"325.24607ms","remote":"127.0.0.1:55948","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-18T19:50:07.02396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.887585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:07.024266Z","caller":"traceutil/trace.go:171","msg":"trace[1135566216] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"709.386651ms","start":"2026-02-18T19:50:06.314863Z","end":"2026-02-18T19:50:07.02425Z","steps":["trace[1135566216] 'process raft request' (duration: 567.104338ms)","trace[1135566216] 'compare' (duration: 141.108879ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:07.024307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:06.314834Z","time spent":"709.453562ms","remote":"127.0.0.1:55688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:50:07.63649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.457988ms","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-18T19:50:07.636661Z","caller":"traceutil/trace.go:171","msg":"trace[1899068949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:940; }","duration":"368.696954ms","start":"2026-02-18T19:50:07.267944Z","end":"2026-02-18T19:50:07.636641Z","steps":["trace[1899068949] 'range keys from in-memory index tree' (duration: 368.345166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:07.636755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:07.267912Z","time spent":"368.828347ms","remote":"127.0.0.1:55948","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-18T19:50:07.639704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.195224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:50:07.643949Z","caller":"traceutil/trace.go:171","msg":"trace[1260558045] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:940; }","duration":"112.436169ms","start":"2026-02-18T19:50:07.527409Z","end":"2026-02-18T19:50:07.639845Z","steps":["trace[1260558045] 'count revisions from in-memory index tree' (duration: 112.083541ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:07.809072Z","caller":"traceutil/trace.go:171","msg":"trace[273148924] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"162.735338ms","start":"2026-02-18T19:50:07.646117Z","end":"2026-02-18T19:50:07.808852Z","steps":["trace[273148924] 'process raft request' (duration: 162.544794ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:07.924595Z","caller":"traceutil/trace.go:171","msg":"trace[364852067] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"185.541603ms","start":"2026-02-18T19:50:07.739016Z","end":"2026-02-18T19:50:07.924557Z","steps":["trace[364852067] 'process raft request' (duration: 185.499152ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:07.924613Z","caller":"traceutil/trace.go:171","msg":"trace[482807264] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"278.258763ms","start":"2026-02-18T19:50:07.646304Z","end":"2026-02-18T19:50:07.924562Z","steps":["trace[482807264] 'process raft request' (duration: 242.660656ms)","trace[482807264] 'compare' (duration: 35.264519ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:07.924927Z","caller":"traceutil/trace.go:171","msg":"trace[1015442931] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"276.723499ms","start":"2026-02-18T19:50:07.64819Z","end":"2026-02-18T19:50:07.924913Z","steps":["trace[1015442931] 'process raft request' (duration: 276.25532ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:07.92505Z","caller":"traceutil/trace.go:171","msg":"trace[1219133628] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"275.646557ms","start":"2026-02-18T19:50:07.649395Z","end":"2026-02-18T19:50:07.925042Z","steps":["trace[1219133628] 'process raft request' (duration: 275.088515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:08.632799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.340111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:50:08.632858Z","caller":"traceutil/trace.go:171","msg":"trace[842839346] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:945; }","duration":"429.455724ms","start":"2026-02-18T19:50:08.203389Z","end":"2026-02-18T19:50:08.632845Z","steps":["trace[842839346] 'count revisions from in-memory index tree' (duration: 429.247409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:08.632885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:08.203365Z","time spent":"429.513845ms","remote":"127.0.0.1:56052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:50:08.633026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.29315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:08.633044Z","caller":"traceutil/trace.go:171","msg":"trace[1426114910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:945; }","duration":"389.344022ms","start":"2026-02-18T19:50:08.243695Z","end":"2026-02-18T19:50:08.633039Z","steps":["trace[1426114910] 'range keys from in-memory index tree' (duration: 389.237929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:08.63306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:08.243673Z","time spent":"389.383233ms","remote":"127.0.0.1:55674","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-18T19:50:08.633294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.54675ms","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-18T19:50:08.633313Z","caller":"traceutil/trace.go:171","msg":"trace[944176485] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:945; }","duration":"247.605401ms","start":"2026-02-18T19:50:08.385702Z","end":"2026-02-18T19:50:08.633307Z","steps":["trace[944176485] 'count revisions from in-memory index tree' (duration: 247.475749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:08.633402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.182549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:08.633417Z","caller":"traceutil/trace.go:171","msg":"trace[183303037] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:945; }","duration":"221.199929ms","start":"2026-02-18T19:50:08.412213Z","end":"2026-02-18T19:50:08.633413Z","steps":["trace[183303037] 'count revisions from in-memory index tree' (duration: 221.094077ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:09.198669Z","caller":"traceutil/trace.go:171","msg":"trace[1148762991] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"436.075224ms","start":"2026-02-18T19:50:08.762567Z","end":"2026-02-18T19:50:09.198642Z","steps":["trace[1148762991] 'process raft request' (duration: 435.91171ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:09.201041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:08.762532Z","time spent":"436.219427ms","remote":"127.0.0.1:55948","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-18T19:50:10.651431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287918104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:50:10.651537Z","caller":"traceutil/trace.go:171","msg":"trace[1120134475] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:946; }","duration":"1.288081278s","start":"2026-02-18T19:50:09.363432Z","end":"2026-02-18T19:50:10.651514Z","steps":["trace[1120134475] 'count revisions from in-memory index tree' (duration: 1.287814082s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.651591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.363418Z","time spent":"1.288160939s","remote":"127.0.0.1:56122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:50:10.651993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.317787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:50:10.652072Z","caller":"traceutil/trace.go:171","msg":"trace[234474470] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:946; }","duration":"875.446169ms","start":"2026-02-18T19:50:09.776605Z","end":"2026-02-18T19:50:10.652051Z","steps":["trace[234474470] 'count revisions from in-memory index tree' (duration: 875.225164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.652117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.77658Z","time spent":"875.525731ms","remote":"127.0.0.1:36934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-18T19:50:10.652461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.508238ms","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-18T19:50:10.652492Z","caller":"traceutil/trace.go:171","msg":"trace[457066010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:946; }","duration":"825.57647ms","start":"2026-02-18T19:50:09.826905Z","end":"2026-02-18T19:50:10.652481Z","steps":["trace[457066010] 'range keys from in-memory index tree' (duration: 825.346015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.652521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.826884Z","time spent":"825.63061ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-18T19:50:10.652669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.834615ms","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-18T19:50:10.652709Z","caller":"traceutil/trace.go:171","msg":"trace[1785515994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"720.891776ms","start":"2026-02-18T19:50:09.931801Z","end":"2026-02-18T19:50:10.652692Z","steps":["trace[1785515994] 'range keys from in-memory index tree' (duration: 720.677251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.652748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.931785Z","time spent":"720.953917ms","remote":"127.0.0.1:55948","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-18T19:50:10.65252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.605325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T19:50:10.652982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.10731ms","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-18T19:50:10.653003Z","caller":"traceutil/trace.go:171","msg":"trace[1156721888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"589.115117ms","start":"2026-02-18T19:50:10.063874Z","end":"2026-02-18T19:50:10.652989Z","steps":["trace[1156721888] 'range keys from in-memory index tree' (duration: 588.516243ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:10.653012Z","caller":"traceutil/trace.go:171","msg":"trace[1715113178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:946; }","duration":"720.149552ms","start":"2026-02-18T19:50:09.932853Z","end":"2026-02-18T19:50:10.653002Z","steps":["trace[1715113178] 'range keys from in-memory index tree' (duration: 720.032809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.653039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:10.063857Z","time spent":"589.172128ms","remote":"127.0.0.1:55674","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-18T19:50:10.653044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.932846Z","time spent":"720.188822ms","remote":"127.0.0.1:55948","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-18T19:50:10.653214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.459046ms","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-18T19:50:10.653241Z","caller":"traceutil/trace.go:171","msg":"trace[1581135595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"719.497516ms","start":"2026-02-18T19:50:09.933734Z","end":"2026-02-18T19:50:10.653231Z","steps":["trace[1581135595] 'range keys from in-memory index tree' (duration: 719.393344ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.653267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.933727Z","time spent":"719.533537ms","remote":"127.0.0.1:55948","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-18T19:50:10.654202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.254751ms","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-18T19:50:10.654276Z","caller":"traceutil/trace.go:171","msg":"trace[2141728893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:946; }","duration":"703.091458ms","start":"2026-02-18T19:50:09.951165Z","end":"2026-02-18T19:50:10.654256Z","steps":["trace[2141728893] 'range keys from in-memory index tree' (duration: 702.196339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:10.654323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:09.951159Z","time spent":"703.145669ms","remote":"127.0.0.1:55948","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-18T19:50:11.404179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.821457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:11.404494Z","caller":"traceutil/trace.go:171","msg":"trace[1362845661] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:986; }","duration":"336.774655ms","start":"2026-02-18T19:50:11.067668Z","end":"2026-02-18T19:50:11.404442Z","steps":["trace[1362845661] 'read index received' (duration: 199.56208ms)","trace[1362845661] 'applied index is now lower than readState.Index' (duration: 137.211075ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:11.404576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.920918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:11.404746Z","caller":"traceutil/trace.go:171","msg":"trace[1167079510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:951; }","duration":"337.148403ms","start":"2026-02-18T19:50:11.067587Z","end":"2026-02-18T19:50:11.404736Z","steps":["trace[1167079510] 'agreement among raft nodes before linearized reading' (duration: 336.945899ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:11.404797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:11.067564Z","time spent":"337.223904ms","remote":"127.0.0.1:55674","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-18T19:50:11.405291Z","caller":"traceutil/trace.go:171","msg":"trace[1954154851] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"741.76469ms","start":"2026-02-18T19:50:10.663512Z","end":"2026-02-18T19:50:11.405277Z","steps":["trace[1954154851] 'process raft request' (duration: 603.766269ms)","trace[1954154851] 'compare' (duration: 136.718645ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:11.405509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:10.663507Z","time spent":"741.821031ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:11.405835Z","caller":"traceutil/trace.go:171","msg":"trace[408661839] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"731.622884ms","start":"2026-02-18T19:50:10.674186Z","end":"2026-02-18T19:50:11.405809Z","steps":["trace[408661839] 'process raft request' (duration: 730.144334ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:11.40681Z","caller":"traceutil/trace.go:171","msg":"trace[485377156] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"740.881981ms","start":"2026-02-18T19:50:10.665915Z","end":"2026-02-18T19:50:11.406797Z","steps":["trace[485377156] 'process raft request' (duration: 738.347217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:11.408003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:10.665908Z","time spent":"741.977815ms","remote":"127.0.0.1:55948","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-18T19:50:11.406879Z","caller":"traceutil/trace.go:171","msg":"trace[1250625996] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"740.77428ms","start":"2026-02-18T19:50:10.666097Z","end":"2026-02-18T19:50:11.406872Z","steps":["trace[1250625996] 'process raft request' (duration: 738.205885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:11.408734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:10.66609Z","time spent":"742.578917ms","remote":"127.0.0.1:55948","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-18T19:50:11.409717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:10.674172Z","time spent":"733.534845ms","remote":"127.0.0.1:55948","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-18T19:50:12.794931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.515134ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-18T19:50:12.795286Z","caller":"traceutil/trace.go:171","msg":"trace[447755749] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:990; }","duration":"731.727096ms","start":"2026-02-18T19:50:12.063536Z","end":"2026-02-18T19:50:12.795263Z","steps":["trace[447755749] 'read index received' (duration: 69.836794ms)","trace[447755749] 'applied index is now lower than readState.Index' (duration: 661.888912ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:12.795372Z","caller":"traceutil/trace.go:171","msg":"trace[1176641780] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"741.249889ms","start":"2026-02-18T19:50:12.054115Z","end":"2026-02-18T19:50:12.795365Z","steps":["trace[1176641780] 'process raft request' (duration: 740.883141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:12.795441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:12.054087Z","time spent":"741.304969ms","remote":"127.0.0.1:55948","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-18T19:50:13.007219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.205641ms","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-18T19:50:13.007272Z","caller":"traceutil/trace.go:171","msg":"trace[403217392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:952; }","duration":"286.316762ms","start":"2026-02-18T19:50:12.720941Z","end":"2026-02-18T19:50:13.007258Z","steps":["trace[403217392] 'agreement among raft nodes before linearized reading' (duration: 74.630945ms)","trace[403217392] 'range keys from in-memory index tree' (duration: 211.532144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:13.00725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.002152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T19:50:13.007311Z","caller":"traceutil/trace.go:171","msg":"trace[940671708] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:952; }","duration":"218.090483ms","start":"2026-02-18T19:50:12.789207Z","end":"2026-02-18T19:50:13.007298Z","steps":["trace[940671708] 'count revisions from in-memory index tree' (duration: 211.607815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.00747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.938805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:13.007486Z","caller":"traceutil/trace.go:171","msg":"trace[1439228516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"943.981606ms","start":"2026-02-18T19:50:12.063499Z","end":"2026-02-18T19:50:13.007481Z","steps":["trace[1439228516] 'agreement among raft nodes before linearized reading' (duration: 732.060024ms)","trace[1439228516] 'range keys from in-memory index tree' (duration: 211.897412ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:13.007501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:12.063492Z","time spent":"944.004496ms","remote":"127.0.0.1:55660","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-18T19:50:13.543955Z","caller":"traceutil/trace.go:171","msg":"trace[1697485210] linearizableReadLoop","detail":"{readStateIndex:993; appliedIndex:992; }","duration":"480.57166ms","start":"2026-02-18T19:50:13.063368Z","end":"2026-02-18T19:50:13.543939Z","steps":["trace[1697485210] 'read index received' (duration: 480.402736ms)","trace[1697485210] 'applied index is now lower than readState.Index' (duration: 168.264µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:13.544076Z","caller":"traceutil/trace.go:171","msg":"trace[480598536] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"533.679679ms","start":"2026-02-18T19:50:13.01038Z","end":"2026-02-18T19:50:13.54406Z","steps":["trace[480598536] 'process raft request' (duration: 533.438123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.544105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.731794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:13.544167Z","caller":"traceutil/trace.go:171","msg":"trace[1544817609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"480.838386ms","start":"2026-02-18T19:50:13.063322Z","end":"2026-02-18T19:50:13.544161Z","steps":["trace[1544817609] 'agreement among raft nodes before linearized reading' (duration: 480.745284ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.544167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.010348Z","time spent":"533.770631ms","remote":"127.0.0.1:55948","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-18T19:50:13.544225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.063284Z","time spent":"480.934148ms","remote":"127.0.0.1:55674","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-18T19:50:13.54438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.224898ms","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-18T19:50:13.544404Z","caller":"traceutil/trace.go:171","msg":"trace[2022670831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:953; }","duration":"130.282719ms","start":"2026-02-18T19:50:13.414115Z","end":"2026-02-18T19:50:13.544398Z","steps":["trace[2022670831] 'agreement among raft nodes before linearized reading' (duration: 130.211918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.544481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.61732ms","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-18T19:50:13.544497Z","caller":"traceutil/trace.go:171","msg":"trace[1513843427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:953; }","duration":"126.652411ms","start":"2026-02-18T19:50:13.417841Z","end":"2026-02-18T19:50:13.544494Z","steps":["trace[1513843427] 'agreement among raft nodes before linearized reading' (duration: 126.6149ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.544577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.00004ms","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-18T19:50:13.544595Z","caller":"traceutil/trace.go:171","msg":"trace[2002915142] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:953; }","duration":"128.035971ms","start":"2026-02-18T19:50:13.416554Z","end":"2026-02-18T19:50:13.54459Z","steps":["trace[2002915142] 'agreement among raft nodes before linearized reading' (duration: 127.99732ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:13.544706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.609263ms","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-18T19:50:13.54474Z","caller":"traceutil/trace.go:171","msg":"trace[141748690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:953; }","duration":"129.665945ms","start":"2026-02-18T19:50:13.415068Z","end":"2026-02-18T19:50:13.544734Z","steps":["trace[141748690] 'agreement among raft nodes before linearized reading' (duration: 129.558373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:14.178258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.117037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:14.178376Z","caller":"traceutil/trace.go:171","msg":"trace[2141547933] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:993; }","duration":"113.992872ms","start":"2026-02-18T19:50:14.064374Z","end":"2026-02-18T19:50:14.178367Z","steps":["trace[2141547933] 'read index received' (duration: 104.486951ms)","trace[2141547933] 'applied index is now lower than readState.Index' (duration: 9.505321ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:14.178415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.040603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:14.178427Z","caller":"traceutil/trace.go:171","msg":"trace[963826234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"114.079474ms","start":"2026-02-18T19:50:14.064343Z","end":"2026-02-18T19:50:14.178422Z","steps":["trace[963826234] 'agreement among raft nodes before linearized reading' (duration: 114.047364ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:14.178568Z","caller":"traceutil/trace.go:171","msg":"trace[1278413743] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"630.420274ms","start":"2026-02-18T19:50:13.548142Z","end":"2026-02-18T19:50:14.178563Z","steps":["trace[1278413743] 'process raft request' (duration: 329.952451ms)","trace[1278413743] 'compare' (duration: 299.956543ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:14.178595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.548134Z","time spent":"630.446075ms","remote":"127.0.0.1:55948","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-18T19:50:14.178655Z","caller":"traceutil/trace.go:171","msg":"trace[995373289] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"629.413173ms","start":"2026-02-18T19:50:13.549237Z","end":"2026-02-18T19:50:14.17865Z","steps":["trace[995373289] 'process raft request' (duration: 629.076216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:14.178676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.54923Z","time spent":"629.433693ms","remote":"127.0.0.1:55948","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-18T19:50:14.178728Z","caller":"traceutil/trace.go:171","msg":"trace[1258572665] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"624.745974ms","start":"2026-02-18T19:50:13.553978Z","end":"2026-02-18T19:50:14.178724Z","steps":["trace[1258572665] 'process raft request' (duration: 624.355965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:14.17875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.55397Z","time spent":"624.768394ms","remote":"127.0.0.1:55948","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-18T19:50:14.178811Z","caller":"traceutil/trace.go:171","msg":"trace[1637497766] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"623.907316ms","start":"2026-02-18T19:50:13.554901Z","end":"2026-02-18T19:50:14.178808Z","steps":["trace[1637497766] 'process raft request' (duration: 623.448817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:14.178833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:13.554893Z","time spent":"623.927677ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:50:15.070379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.005629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:15.070441Z","caller":"traceutil/trace.go:171","msg":"trace[1326176258] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:957; }","duration":"144.129742ms","start":"2026-02-18T19:50:14.926298Z","end":"2026-02-18T19:50:15.070427Z","steps":["trace[1326176258] 'count revisions from in-memory index tree' (duration: 143.893797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:15.070522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:14.561008Z","time spent":"509.509384ms","remote":"127.0.0.1:33488","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-18T19:50:15.681091Z","caller":"traceutil/trace.go:171","msg":"trace[2054374454] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"126.529738ms","start":"2026-02-18T19:50:15.554542Z","end":"2026-02-18T19:50:15.681072Z","steps":["trace[2054374454] 'process raft request' (duration: 126.379865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.230352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.642601ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-18T19:50:32.230453Z","caller":"traceutil/trace.go:171","msg":"trace[193781970] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1090; }","duration":"420.416452ms","start":"2026-02-18T19:50:31.810018Z","end":"2026-02-18T19:50:32.230434Z","steps":["trace[193781970] 'read index received' (duration: 54.751µs)","trace[193781970] 'applied index is now lower than readState.Index' (duration: 420.360071ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:32.231285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.25797ms","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-18T19:50:32.231318Z","caller":"traceutil/trace.go:171","msg":"trace[70948883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"421.333541ms","start":"2026-02-18T19:50:31.809974Z","end":"2026-02-18T19:50:32.231308Z","steps":["trace[70948883] 'agreement among raft nodes before linearized reading' (duration: 421.196909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.231349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:31.809954Z","time spent":"421.388192ms","remote":"127.0.0.1:55948","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-18T19:50:32.231522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.460395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:32.231548Z","caller":"traceutil/trace.go:171","msg":"trace[723617282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"165.524956ms","start":"2026-02-18T19:50:32.066014Z","end":"2026-02-18T19:50:32.231539Z","steps":["trace[723617282] 'agreement among raft nodes before linearized reading' (duration: 165.486405ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:32.463326Z","caller":"traceutil/trace.go:171","msg":"trace[465119078] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1091; }","duration":"207.518179ms","start":"2026-02-18T19:50:32.255786Z","end":"2026-02-18T19:50:32.463304Z","steps":["trace[465119078] 'read index received' (duration: 207.302354ms)","trace[465119078] 'applied index is now lower than readState.Index' (duration: 214.965µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T19:50:32.463583Z","caller":"traceutil/trace.go:171","msg":"trace[1991525358] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"225.041551ms","start":"2026-02-18T19:50:32.238529Z","end":"2026-02-18T19:50:32.46357Z","steps":["trace[1991525358] 'process raft request' (duration: 224.639043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.463838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.036549ms","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-18T19:50:32.46387Z","caller":"traceutil/trace.go:171","msg":"trace[2064551439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1047; }","duration":"208.108081ms","start":"2026-02-18T19:50:32.255752Z","end":"2026-02-18T19:50:32.46386Z","steps":["trace[2064551439] 'agreement among raft nodes before linearized reading' (duration: 207.982829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.464046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.162532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:471"} {"level":"info","ts":"2026-02-18T19:50:32.464073Z","caller":"traceutil/trace.go:171","msg":"trace[459256223] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1047; }","duration":"208.240014ms","start":"2026-02-18T19:50:32.255825Z","end":"2026-02-18T19:50:32.464065Z","steps":["trace[459256223] 'agreement among raft nodes before linearized reading' (duration: 208.164292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.465465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.188048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:32.465528Z","caller":"traceutil/trace.go:171","msg":"trace[155951819] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1047; }","duration":"133.461156ms","start":"2026-02-18T19:50:32.332038Z","end":"2026-02-18T19:50:32.465499Z","steps":["trace[155951819] 'agreement among raft nodes before linearized reading' (duration: 132.189159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.46605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.156559ms","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-18T19:50:32.466089Z","caller":"traceutil/trace.go:171","msg":"trace[1686080090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1047; }","duration":"165.221371ms","start":"2026-02-18T19:50:32.300855Z","end":"2026-02-18T19:50:32.466077Z","steps":["trace[1686080090] 'agreement among raft nodes before linearized reading' (duration: 165.061807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.466598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.547129ms","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-18T19:50:32.466649Z","caller":"traceutil/trace.go:171","msg":"trace[478642778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1047; }","duration":"167.616061ms","start":"2026-02-18T19:50:32.299022Z","end":"2026-02-18T19:50:32.466639Z","steps":["trace[478642778] 'agreement among raft nodes before linearized reading' (duration: 167.416377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.46717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.387283ms","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-18T19:50:32.467206Z","caller":"traceutil/trace.go:171","msg":"trace[1508532511] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1047; }","duration":"172.427344ms","start":"2026-02-18T19:50:32.294769Z","end":"2026-02-18T19:50:32.467197Z","steps":["trace[1508532511] 'agreement among raft nodes before linearized reading' (duration: 172.251399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:32.960586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.602351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:32.960686Z","caller":"traceutil/trace.go:171","msg":"trace[10242162] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"485.271371ms","start":"2026-02-18T19:50:32.475397Z","end":"2026-02-18T19:50:32.960669Z","steps":["trace[10242162] 'process raft request' (duration: 358.515297ms)","trace[10242162] 'compare' (duration: 126.434797ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:32.960759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.475381Z","time spent":"485.350952ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:50:33.352143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.61344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T19:50:33.352297Z","caller":"traceutil/trace.go:171","msg":"trace[692581947] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"873.910946ms","start":"2026-02-18T19:50:32.478369Z","end":"2026-02-18T19:50:33.35228Z","steps":["trace[692581947] 'process raft request' (duration: 739.097432ms)","trace[692581947] 'compare' (duration: 134.539658ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:33.352405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.478351Z","time spent":"874.030039ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T19:50:33.352552Z","caller":"traceutil/trace.go:171","msg":"trace[1682539263] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"874.03322ms","start":"2026-02-18T19:50:32.47851Z","end":"2026-02-18T19:50:33.352543Z","steps":["trace[1682539263] 'process raft request' (duration: 873.719482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:33.352613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.478506Z","time spent":"874.06373ms","remote":"127.0.0.1:55948","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-18T19:50:33.353005Z","caller":"traceutil/trace.go:171","msg":"trace[439186725] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"874.432248ms","start":"2026-02-18T19:50:32.478549Z","end":"2026-02-18T19:50:33.352982Z","steps":["trace[439186725] 'process raft request' (duration: 873.956048ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:33.353135Z","caller":"traceutil/trace.go:171","msg":"trace[651610352] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"874.54793ms","start":"2026-02-18T19:50:32.478574Z","end":"2026-02-18T19:50:33.353122Z","steps":["trace[651610352] 'process raft request' (duration: 874.275254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:33.353179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.478546Z","time spent":"874.53038ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T19:50:33.353201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.478571Z","time spent":"874.596121ms","remote":"127.0.0.1:55948","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-18T19:50:33.353442Z","caller":"traceutil/trace.go:171","msg":"trace[1785688636] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"147.824701ms","start":"2026-02-18T19:50:33.205607Z","end":"2026-02-18T19:50:33.353432Z","steps":["trace[1785688636] 'process raft request' (duration: 147.78393ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T19:50:33.353514Z","caller":"traceutil/trace.go:171","msg":"trace[328757285] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"765.930533ms","start":"2026-02-18T19:50:32.587574Z","end":"2026-02-18T19:50:33.353505Z","steps":["trace[328757285] 'process raft request' (duration: 765.497984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:33.353558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.587499Z","time spent":"766.032815ms","remote":"127.0.0.1:55740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T19:50:33.35408Z","caller":"traceutil/trace.go:171","msg":"trace[1439750436] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1093; }","duration":"454.110307ms","start":"2026-02-18T19:50:32.899955Z","end":"2026-02-18T19:50:33.354065Z","steps":["trace[1439750436] 'read index received' (duration: 317.518435ms)","trace[1439750436] 'applied index is now lower than readState.Index' (duration: 136.589882ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T19:50:33.354308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.341972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:33.354339Z","caller":"traceutil/trace.go:171","msg":"trace[1583971117] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1054; }","duration":"454.402864ms","start":"2026-02-18T19:50:32.899927Z","end":"2026-02-18T19:50:33.354329Z","steps":["trace[1583971117] 'agreement among raft nodes before linearized reading' (duration: 454.348333ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:33.354369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T19:50:32.899911Z","time spent":"454.451485ms","remote":"127.0.0.1:55948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-18T19:50:33.354456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.722542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T19:50:33.354493Z","caller":"traceutil/trace.go:171","msg":"trace[810174544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"287.811034ms","start":"2026-02-18T19:50:33.066675Z","end":"2026-02-18T19:50:33.354472Z","steps":["trace[810174544] 'agreement among raft nodes before linearized reading' (duration: 287.763863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T19:50:33.354732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.10519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-02-18T19:50:33.354763Z","caller":"traceutil/trace.go:171","msg":"trace[421676183] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1054; }","duration":"263.160251ms","start":"2026-02-18T19:50:33.091593Z","end":"2026-02-18T19:50:33.354754Z","steps":["trace[421676183] 'agreement among raft nodes before linearized reading' (duration: 263.057449ms)"],"step_count":1}